container-test-run-syncthing-service
checks.aarch64-linux.syncthing-service
· 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 machine1, machine2, machine3, machine4,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 VMs12machine2: systemd-nspawn running (pid 55)13machine1: systemd-nspawn running (pid 54)14machine3: systemd-nspawn running (pid 56)15machine4: systemd-nspawn running (pid 57)16machine1: Waiting for journal at /build/vm-state-machine1/var/log/journal...17machine2: Waiting for journal at /build/vm-state-machine2/var/log/journal...18machine4: Waiting for journal at /build/vm-state-machine4/var/log/journal...19machine3: Waiting for journal at /build/vm-state-machine3/var/log/journal...20(finished: start all VMs, in 0.00 seconds)21machine3: waiting for unit syncthing.service22nixos-nspawn(machine4): TAP vde-tap1 not found; container will be isolated from VDE23nixos-nspawn(machine4): 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(machine3): TAP vde-tap1 not found; container will be isolated from VDE25nixos-nspawn(machine3): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths.26nixos-nspawn(machine2): TAP vde-tap1 not found; container will be isolated from VDE27nixos-nspawn(machine2): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths.28nixos-nspawn(machine1): TAP vde-tap1 not found; container will be isolated from VDE29nixos-nspawn(machine1): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths.30Note: 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.31Note: 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.32░ Spawning container machine4 on /build/vm-state-machine4.33Note: 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.34░ Spawning container machine3 on /build/vm-state-machine3.35Note: 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.36░ Spawning container machine2 on /build/vm-state-machine2.37░ Spawning container machine1 on /build/vm-state-machine1.38machine2 # [27762.252700] machine2 systemd-journald[95]: Journal started39machine2 # [27762.252759] machine2 systemd-journald[95]: Runtime Journal (/run/log/journal/efff0c6850804850ab7eab2794010d00) is 8M, max 2.5G, 2.4G free.40machine2 # [27762.256791] machine2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.41machine2 # [27762.265107] machine2 systemd[1]: Starting Flush Journal to Persistent Storage...42machine2 # [27762.265924] machine2 systemd[1]: Starting Network Name Resolution...43machine2 # [27762.266615] machine2 systemd[1]: Starting Create Static Device Nodes in /dev...44machine4 # [27762.254272] machine4 systemd-journald[96]: Journal started45machine2 # [27762.275353] machine2 systemd-journald[95]: Time spent on flushing to /var/log/journal/efff0c6850804850ab7eab2794010d00 is 1.302ms for 6 entries.46machine4 # [27762.254330] machine4 systemd-journald[96]: Runtime Journal (/run/log/journal/165166da8add4c7ba84db692abfd2e6c) is 8M, max 2.5G, 2.4G free.47machine2 # [27762.275353] machine2 systemd-journald[95]: System Journal (/var/log/journal/efff0c6850804850ab7eab2794010d00) is 8M, max 4G, 3.9G free.48machine4 # [27762.258077] machine4 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.49machine1 # [27762.258493] machine1 systemd-journald[96]: Journal started50machine2 # [27762.279581] machine2 systemd[1]: Finished Create Static Device Nodes in /dev.51machine2 # [27762.280389] machine2 systemd[1]: Reached target Preparation for Local File Systems.52machine1 # [27762.258541] machine1 systemd-journald[96]: Runtime Journal (/run/log/journal/156fdb62e4a543b9a52bcb920e9d28b6) is 8M, max 2.5G, 2.4G free.53machine2 # [27762.280653] machine2 systemd[1]: Reached target Local File Systems.54machine1 # [27762.265597] machine1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.55machine2 # [27762.281698] machine2 systemd[1]: Listening on Boot Loader Control Service Socket.56machine1 # [27762.275185] machine1 systemd[1]: Starting Flush Journal to Persistent Storage...57machine2 # [27762.281751] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container58machine1 # [27762.276247] machine1 systemd[1]: Starting Network Name Resolution...59machine2 # [27762.282864] machine2 systemd[1]: Starting Save Transient machine-id to Disk...60machine1 # [27762.276893] machine1 systemd[1]: Starting Create Static Device Nodes in /dev...61machine2 # [27762.282919] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys62machine1 # [27762.284793] machine1 systemd-journald[96]: Time spent on flushing to /var/log/journal/156fdb62e4a543b9a52bcb920e9d28b6 is 1.398ms for 6 entries.63machine1 # [27762.284793] machine1 systemd-journald[96]: System Journal (/var/log/journal/156fdb62e4a543b9a52bcb920e9d28b6) is 8M, max 4G, 3.9G free.64machine4 # [27762.268196] machine4 systemd[1]: Starting Flush Journal to Persistent Storage...65machine2 # [27762.292065] machine2 systemd[1]: Finished Flush Journal to Persistent Storage.66machine1 # [27762.295204] machine1 systemd[1]: Finished Create Static Device Nodes in /dev.67machine4 # [27762.269206] machine4 systemd[1]: Starting Network Name Resolution...68machine2 # [27762.293974] machine2 systemd[1]: Starting Create System Files and Directories...69machine1 # [27762.295951] machine1 systemd[1]: Reached target Preparation for Local File Systems.70machine2 # [27762.308620] machine2 systemd-tmpfiles[138]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted71machine1 # [27762.296167] machine1 systemd[1]: Reached target Local File Systems.72machine2 # [27762.308822] machine2 systemd-tmpfiles[138]: fchmod() of /var/log/journal failed: Operation not permitted73machine1 # [27762.297125] machine1 systemd[1]: Listening on Boot Loader Control Service Socket.74machine2 # [27762.308971] machine2 systemd-tmpfiles[138]: fchmod() of /var/log/journal/efff0c6850804850ab7eab2794010d00 failed: Operation not permitted75machine1 # [27762.297175] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container76machine2 # [27762.309202] machine2 systemd-tmpfiles[138]: fchmod() of /run/log/journal failed: Operation not permitted77machine3 # [27762.248649] machine3 systemd-journald[96]: Journal started78machine4 # [27762.269879] machine4 systemd[1]: Starting Create Static Device Nodes in /dev...79machine2 # [27762.310733] machine2 systemd[1]: Finished Create System Files and Directories.80machine1 # [27762.298058] machine1 systemd[1]: Starting Save Transient machine-id to Disk...81machine3 # [27762.248699] machine3 systemd-journald[96]: Runtime Journal (/run/log/journal/19265f3423b44a0d86a8212b642f20de) is 8M, max 2.5G, 2.4G free.82machine2 # [27762.311891] machine2 systemd[1]: Starting Rebuild Journal Catalog...83machine4 # [27762.277100] machine4 systemd-journald[96]: Time spent on flushing to /var/log/journal/165166da8add4c7ba84db692abfd2e6c is 1.624ms for 6 entries.84machine1 # [27762.298097] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys85machine2 # [27762.312705] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP...86machine3 # [27762.256748] machine3 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.87machine4 # [27762.277100] machine4 systemd-journald[96]: System Journal (/var/log/journal/165166da8add4c7ba84db692abfd2e6c) is 8M, max 4G, 3.9G free.88machine2 # [27762.325296] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP.89machine1 # [27762.304748] machine1 systemd[1]: Finished Flush Journal to Persistent Storage.90machine3 # [27762.266799] machine3 systemd[1]: Starting Flush Journal to Persistent Storage...91machine4 # [27762.286062] machine4 systemd[1]: Finished Create Static Device Nodes in /dev.92machine2 # [27762.330738] machine2 systemd[1]: Finished Rebuild Journal Catalog.93machine1 # [27762.306373] machine1 systemd[1]: Starting Create System Files and Directories...94machine3 # [27762.267860] machine3 systemd[1]: Starting Network Name Resolution...95machine4 # [27762.286784] machine4 systemd[1]: Reached target Preparation for Local File Systems.96machine2 # [27762.332166] machine2 systemd[1]: Starting Update is Completed...97machine1 # [27762.321105] machine1 systemd-tmpfiles[143]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted98machine3 # [27762.268549] machine3 systemd[1]: Starting Create Static Device Nodes in /dev...99machine2 # [27762.342233] machine2 systemd[1]: Finished Update is Completed.100machine4 # [27762.286904] machine4 systemd[1]: Reached target Local File Systems.101machine1 # [27762.321310] machine1 systemd-tmpfiles[143]: fchmod() of /var/log/journal failed: Operation not permitted102machine2 # [27762.350211] machine2 systemd[1]: Finished Save Transient machine-id to Disk.103machine3 # [27762.276473] machine3 systemd-journald[96]: Time spent on flushing to /var/log/journal/19265f3423b44a0d86a8212b642f20de is 1.289ms for 6 entries.104machine4 # [27762.287798] machine4 systemd[1]: Listening on Boot Loader Control Service Socket.105machine3 # [27762.276473] machine3 systemd-journald[96]: System Journal (/var/log/journal/19265f3423b44a0d86a8212b642f20de) is 8M, max 4G, 3.9G free.106machine4 # [27762.287849] machine4 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container107machine3 # [27762.284062] machine3 systemd[1]: Finished Create Static Device Nodes in /dev.108machine4 # [27762.288742] machine4 systemd[1]: Starting Save Transient machine-id to Disk...109machine3 # [27762.284791] machine3 systemd[1]: Reached target Preparation for Local File Systems.110machine4 # [27762.288782] machine4 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys111machine4 # [27762.292672] machine4 systemd[1]: Finished Flush Journal to Persistent Storage.112machine3 # [27762.284919] machine3 systemd[1]: Reached target Local File Systems.113machine4 # [27762.293618] machine4 systemd[1]: Starting Create System Files and Directories...114machine3 # [27762.285801] machine3 systemd[1]: Listening on Boot Loader Control Service Socket.115machine4 # [27762.308690] machine4 systemd-tmpfiles[140]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted116machine3 # [27762.285850] machine3 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container117machine4 # [27762.308904] machine4 systemd-tmpfiles[140]: fchmod() of /var/log/journal failed: Operation not permitted118machine3 # [27762.286785] machine3 systemd[1]: Starting Save Transient machine-id to Disk...119machine4 # [27762.309053] machine4 systemd-tmpfiles[140]: fchmod() of /var/log/journal/165166da8add4c7ba84db692abfd2e6c failed: Operation not permitted120machine3 # [27762.286824] machine3 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys121machine4 # [27762.309278] machine4 systemd-tmpfiles[140]: fchmod() of /run/log/journal failed: Operation not permitted122machine3 # [27762.292102] machine3 systemd[1]: Finished Flush Journal to Persistent Storage.123machine4 # [27762.310669] machine4 systemd[1]: Finished Create System Files and Directories.124machine3 # [27762.293719] machine3 systemd[1]: Starting Create System Files and Directories...125machine4 # [27762.311780] machine4 systemd[1]: Starting Rebuild Journal Catalog...126machine3 # [27762.309400] machine3 systemd-tmpfiles[139]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted127machine4 # [27762.312510] machine4 systemd[1]: Starting Record System Boot/Shutdown in UTMP...128machine3 # [27762.309603] machine3 systemd-tmpfiles[139]: fchmod() of /var/log/journal failed: Operation not permitted129machine4 # [27762.324076] machine4 systemd[1]: Finished Record System Boot/Shutdown in UTMP.130machine3 # [27762.309745] machine3 systemd-tmpfiles[139]: fchmod() of /var/log/journal/19265f3423b44a0d86a8212b642f20de failed: Operation not permitted131machine4 # [27762.331137] machine4 systemd[1]: Finished Rebuild Journal Catalog.132machine3 # [27762.309965] machine3 systemd-tmpfiles[139]: fchmod() of /run/log/journal failed: Operation not permitted133machine4 # [27762.332276] machine4 systemd[1]: Starting Update is Completed...134machine3 # [27762.311341] machine3 systemd[1]: Finished Create System Files and Directories.135machine4 # [27762.341899] machine4 systemd[1]: Finished Update is Completed.136machine3 # [27762.312407] machine3 systemd[1]: Starting Rebuild Journal Catalog...137machine4 # [27762.350256] machine4 systemd[1]: Finished Save Transient machine-id to Disk.138machine3 # [27762.313103] machine3 systemd[1]: Starting Record System Boot/Shutdown in UTMP...139machine1 # [27762.321447] machine1 systemd-tmpfiles[143]: fchmod() of /var/log/journal/156fdb62e4a543b9a52bcb920e9d28b6 failed: Operation not permitted140machine3 # [27762.326367] machine3 systemd[1]: Finished Record System Boot/Shutdown in UTMP.141machine1 # [27762.321662] machine1 systemd-tmpfiles[143]: fchmod() of /run/log/journal failed: Operation not permitted142machine3 # [27762.335121] machine3 systemd[1]: Finished Rebuild Journal Catalog.143machine1 # [27762.323176] machine1 systemd[1]: Finished Create System Files and Directories.144machine3 # [27762.336767] machine3 systemd[1]: Starting Update is Completed...145machine1 # [27762.324265] machine1 systemd[1]: Starting Rebuild Journal Catalog...146machine3 # [27762.347381] machine3 systemd[1]: Finished Update is Completed.147machine1 # [27762.324974] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...148machine3 # [27762.350141] machine3 systemd[1]: Finished Save Transient machine-id to Disk.149machine1 # [27762.338725] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.150machine1 # [27762.343898] machine1 systemd[1]: Finished Rebuild Journal Catalog.151machine1 # [27762.344904] machine1 systemd[1]: Starting Update is Completed...152machine1 # [27762.349764] machine1 systemd[1]: Finished Save Transient machine-id to Disk.153machine1 # [27762.354633] machine1 systemd[1]: Finished Update is Completed.154machine2 # [27762.417535] machine2 systemd[1]: Finished Firewall.155machine2 # [27762.417700] machine2 systemd[1]: Reached target Preparation for Network.156machine2 # [27762.417911] machine2 systemd[1]: Listening on Network Management Resolve Hook Socket.157machine2 # [27762.418919] machine2 systemd[1]: Starting Network Management...158machine3 # [27762.416567] machine3 systemd[1]: Finished Firewall.159machine3 # [27762.417180] machine3 systemd[1]: Reached target Preparation for Network.160machine3 # [27762.417485] machine3 systemd[1]: Listening on Network Management Resolve Hook Socket.161machine3 # [27762.418570] machine3 systemd[1]: Starting Network Management...162machine1 # [27762.456360] machine1 systemd[1]: Finished Firewall.163machine1 # [27762.456555] machine1 systemd[1]: Reached target Preparation for Network.164machine1 # [27762.456784] machine1 systemd[1]: Listening on Network Management Resolve Hook Socket.165machine1 # [27762.457886] machine1 systemd[1]: Starting Network Management...166machine4 # [27762.417605] machine4 systemd[1]: Finished Firewall.167machine4 # [27762.417763] machine4 systemd[1]: Reached target Preparation for Network.168machine4 # [27762.417957] machine4 systemd[1]: Listening on Network Management Resolve Hook Socket.169machine4 # [27762.418945] machine4 systemd[1]: Starting Network Management...170machine2 # [27762.840930] machine2 systemd-networkd[217]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted171machine2 # [27762.841017] machine2 systemd-networkd[217]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted172machine2 # [27762.847570] machine2 systemd-networkd[217]: /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.173machine2 # [27762.847736] machine2 systemd-networkd[217]: /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.174machine2 # [27762.847874] machine2 systemd-networkd[217]: lo: Link UP175machine2 # [27762.847880] machine2 systemd-networkd[217]: lo: Gained carrier176machine2 # [27762.848067] machine2 systemd-networkd[217]: eth1: Configuring with /etc/systemd/network/40-eth1.network.177machine2 # [27762.848429] machine2 systemd[1]: Started Network Management.178machine2 # [27762.872792] machine2 systemd-networkd[217]: eth1: Link UP179machine2 # [27762.872936] machine2 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...180machine2 # [27762.873173] machine2 systemd-networkd[217]: eth1: Gained carrier181machine2 # [27762.930104] machine2 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.182machine2 # [27762.967071] machine2 systemd-resolved[118]: Positive Trust Anchors:183machine2 # [27762.967085] machine2 systemd-resolved[118]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d184machine2 # [27762.967088] machine2 systemd-resolved[118]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16185machine2 # [27762.967122] machine2 systemd-resolved[118]: 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 test186machine2 # [27762.989147] machine2 systemd-resolved[118]: Using system hostname 'machine2'.187machine2 # [27762.990547] machine2 systemd[1]: Started Network Name Resolution.188machine2 # [27762.990627] machine2 systemd[1]: Reached target Network.189machine2 # [27762.990706] machine2 systemd[1]: Reached target System Initialization.190machine2 # [27762.990764] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container191machine2 # [27762.990796] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories.192machine2 # [27762.990812] machine2 systemd[1]: Reached target Timer Units.193machine2 # [27762.990934] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket.194machine2 # [27762.991051] machine2 systemd[1]: Listening on Nix Daemon Socket.195machine2 # [27762.991163] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.196machine2 # [27762.991185] machine2 systemd[1]: Reached target Socket Units.197machine2 # [27762.991228] machine2 systemd[1]: Reached target Basic System.198machine2 # [27763.032515] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database...199machine2 # [27763.033986] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...200machine2 # [27763.035175] machine2 systemd[1]: Starting Syncthing service...201machine2 # [27763.036561] machine2 systemd[1]: Starting D-Bus System Message Bus...202machine2 # [27763.053013] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database.203machine3 # [27762.832928] machine3 systemd-networkd[218]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted204machine3 # [27762.833022] machine3 systemd-networkd[218]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted205machine3 # [27762.839631] machine3 systemd-networkd[218]: /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.206machine3 # [27762.839795] machine3 systemd-networkd[218]: /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.207machine3 # [27762.839955] machine3 systemd-networkd[218]: lo: Link UP208machine3 # [27762.839958] machine3 systemd-networkd[218]: lo: Gained carrier209machine3 # [27762.840160] machine3 systemd-networkd[218]: eth1: Configuring with /etc/systemd/network/40-eth1.network.210machine3 # [27762.840609] machine3 systemd[1]: Started Network Management.211machine3 # [27762.840628] machine3 systemd-networkd[218]: eth1: Link UP212machine3 # [27762.840948] machine3 systemd-networkd[218]: eth1: Gained carrier213machine3 # [27762.872458] machine3 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...214machine3 # [27762.883528] machine3 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.215machine3 # [27762.967072] machine3 systemd-resolved[120]: Positive Trust Anchors:216machine3 # [27762.967084] machine3 systemd-resolved[120]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d217machine3 # [27762.967087] machine3 systemd-resolved[120]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16218machine3 # [27762.967122] machine3 systemd-resolved[120]: 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 test219machine3 # [27762.989590] machine3 systemd-resolved[120]: Using system hostname 'machine3'.220machine3 # [27762.990908] machine3 systemd[1]: Started Network Name Resolution.221machine3 # [27762.990999] machine3 systemd[1]: Reached target Network.222machine3 # [27762.991078] machine3 systemd[1]: Reached target System Initialization.223machine3 # [27762.991135] machine3 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container224machine3 # [27762.991168] machine3 systemd[1]: Started Daily Cleanup of Temporary Directories.225machine3 # [27762.991189] machine3 systemd[1]: Reached target Timer Units.226machine3 # [27762.991332] machine3 systemd[1]: Listening on D-Bus System Message Bus Socket.227machine3 # [27762.991460] machine3 systemd[1]: Listening on Nix Daemon Socket.228machine3 # [27762.991580] machine3 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.229machine3 # [27762.991607] machine3 systemd[1]: Reached target Socket Units.230machine3 # [27762.991654] machine3 systemd[1]: Reached target Basic System.231machine3 # [27763.032537] machine3 systemd[1]: Starting Import lastlog data into lastlog2 database...232machine3 # [27763.034102] machine3 systemd[1]: Starting Name Service Cache Daemon (nsncd)...233machine3 # [27763.035640] machine3 systemd[1]: Starting Syncthing service...234machine3 # [27763.037139] machine3 systemd[1]: Starting D-Bus System Message Bus...235machine3 # [27763.052505] machine3 systemd[1]: Finished Import lastlog data into lastlog2 database.236machine1 # [27762.828739] machine1 systemd-networkd[218]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted237machine1 # [27762.828841] machine1 systemd-networkd[218]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted238machine1 # [27762.835446] machine1 systemd-networkd[218]: /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.239machine1 # [27762.835610] machine1 systemd-networkd[218]: /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.240machine1 # [27762.835753] machine1 systemd-networkd[218]: lo: Link UP241machine1 # [27762.835756] machine1 systemd-networkd[218]: lo: Gained carrier242machine1 # [27762.835940] machine1 systemd-networkd[218]: eth1: Configuring with /etc/systemd/network/40-eth1.network.243machine1 # [27762.836327] machine1 systemd[1]: Started Network Management.244machine1 # [27762.836404] machine1 systemd-networkd[218]: eth1: Link UP245machine1 # [27762.836727] machine1 systemd-networkd[218]: eth1: Gained carrier246machine1 # [27762.837420] machine1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...247machine1 # [27762.881343] machine1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.248machine1 # [27762.979954] machine1 systemd-resolved[120]: Positive Trust Anchors:249machine1 # [27762.979966] machine1 systemd-resolved[120]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d250machine1 # [27762.979969] machine1 systemd-resolved[120]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16251machine1 # [27762.980018] machine1 systemd-resolved[120]: 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 test252machine1 # [27763.002048] machine1 systemd-resolved[120]: Using system hostname 'machine1'.253machine1 # [27763.003396] machine1 systemd[1]: Started Network Name Resolution.254machine1 # [27763.003483] machine1 systemd[1]: Reached target Network.255machine1 # [27763.003561] machine1 systemd[1]: Reached target System Initialization.256machine1 # [27763.003614] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container257machine1 # [27763.003644] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories.258machine1 # [27763.003659] machine1 systemd[1]: Reached target Timer Units.259machine1 # [27763.003789] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket.260machine1 # [27763.003903] machine1 systemd[1]: Listening on Nix Daemon Socket.261machine1 # [27763.004029] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.262machine1 # [27763.004057] machine1 systemd[1]: Reached target Socket Units.263machine1 # [27763.004103] machine1 systemd[1]: Reached target Basic System.264machine1 # [27763.032918] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database...265machine1 # [27763.034308] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...266machine1 # [27763.035852] machine1 systemd[1]: Starting Syncthing service...267machine1 # [27763.037395] machine1 systemd[1]: Starting D-Bus System Message Bus...268machine1 # [27763.055229] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database.269machine4 # [27762.838681] machine4 systemd-networkd[218]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted270machine4 # [27762.838771] machine4 systemd-networkd[218]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted271machine4 # [27762.845394] machine4 systemd-networkd[218]: /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.272machine4 # [27762.845559] machine4 systemd-networkd[218]: /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.273machine4 # [27762.845704] machine4 systemd-networkd[218]: lo: Link UP274machine4 # [27762.845708] machine4 systemd-networkd[218]: lo: Gained carrier275machine4 # [27762.845870] machine4 systemd-networkd[218]: eth1: Configuring with /etc/systemd/network/40-eth1.network.276machine4 # [27762.846258] machine4 systemd[1]: Started Network Management.277machine4 # [27762.872360] machine4 systemd-networkd[218]: eth1: Link UP278machine4 # [27762.872651] machine4 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...279machine4 # [27762.872838] machine4 systemd-networkd[218]: eth1: Gained carrier280machine4 # [27762.885647] machine4 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.281machine4 # [27762.958900] machine4 systemd-resolved[121]: Positive Trust Anchors:282machine4 # [27762.958913] machine4 systemd-resolved[121]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d283machine4 # [27762.958916] machine4 systemd-resolved[121]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16284machine4 # [27762.958946] machine4 systemd-resolved[121]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test285machine4 # [27762.981090] machine4 systemd-resolved[121]: Using system hostname 'machine4'.286machine4 # [27762.982476] machine4 systemd[1]: Started Network Name Resolution.287machine4 # [27762.982592] machine4 systemd[1]: Reached target Network.288machine4 # [27762.982668] machine4 systemd[1]: Reached target System Initialization.289machine4 # [27762.982720] machine4 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container290machine4 # [27762.982747] machine4 systemd[1]: Started Daily Cleanup of Temporary Directories.291machine4 # [27762.982769] machine4 systemd[1]: Reached target Timer Units.292machine4 # [27762.982917] machine4 systemd[1]: Listening on D-Bus System Message Bus Socket.293machine4 # [27762.983056] machine4 systemd[1]: Listening on Nix Daemon Socket.294machine4 # [27762.983173] machine4 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.295machine4 # [27762.983198] machine4 systemd[1]: Reached target Socket Units.296machine4 # [27762.983247] machine4 systemd[1]: Reached target Basic System.297machine4 # [27762.984489] machine4 systemd[1]: Starting Import lastlog data into lastlog2 database...298machine4 # [27762.985487] machine4 systemd[1]: Starting Name Service Cache Daemon (nsncd)...299machine4 # [27762.986445] machine4 systemd[1]: Starting Syncthing service...300machine4 # [27762.987914] machine4 systemd[1]: Starting D-Bus System Message Bus...301machine4 # [27763.048673] machine4 systemd[1]: Finished Import lastlog data into lastlog2 database.302machine1 # [27763.185090] machine1 systemd[1]: Started Syncthing service.303machine1 # [27763.186208] machine1 systemd[1]: Starting Syncthing configuration updater...304machine1 # [27763.230766] machine1 nsncd[224]: Sep 04 15:09:43.216 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"305machine1 # [27763.230856] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd).306machine1 # [27763.230924] machine1 systemd[1]: Reached target Host and Network Name Lookups.307machine1 # [27763.231236] machine1 systemd[1]: Reached target User and Group Name Lookups.308machine1 # [27763.237319] machine1 systemd[1]: Starting User Login Management...309machine1 # [27763.238070] machine1 systemd[1]: Starting Permit User Sessions...310machine1 # [27763.247015] machine1 cfkxq629vg44wbbvajvr4k0ws7fvj6w1-merge-syncthing-config[255]: I/O warning : failed to load "/var/lib/syncthing/config.xml": No such file or directory311machine1 # [27763.252685] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.312machine1 # [27763.253869] machine1 systemd[1]: Finished Permit User Sessions.313machine1 # [27763.255387] machine1 systemd[1]: Started Console Getty.314machine1 # [27763.255434] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0315machine1 # [27763.255454] machine1 systemd[1]: Reached target Login Prompts.316machine1 # [27763.340525] machine1 dbus-broker-launch[226]: Looking up NSS user entry for 'systemd-timesync'...317machine1 # [27763.342399] machine1 dbus-broker-launch[226]: NSS returned no entry for 'systemd-timesync'318machine1 # [27763.342399] machine1 dbus-broker-launch[226]: Invalid user-name in /nix/store/zpmlv369hvpj2hz60qxfc7qh0hy3kyg8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"319machine1 # [27763.342849] machine1 systemd[1]: Started D-Bus System Message Bus.320machine1 # [27763.349712] machine1 dbus-broker-launch[226]: Ready321machine4 # [27763.213335] machine4 nsncd[224]: Sep 04 15:09:43.199 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"322machine4 # [27763.236351] machine4 systemd[1]: Started Syncthing service.323machine4 # [27763.245626] machine4 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.324machine4 # [27763.246459] machine4 systemd[1]: Started Name Service Cache Daemon (nsncd).325machine4 # [27763.246854] machine4 systemd[1]: Reached target Host and Network Name Lookups.326machine4 # [27763.247018] machine4 systemd[1]: Reached target User and Group Name Lookups.327machine4 # [27763.247821] machine4 systemd[1]: Starting Syncthing configuration updater...328machine4 # [27763.249315] machine4 systemd[1]: Starting User Login Management...329machine4 # [27763.250091] machine4 systemd[1]: Starting Permit User Sessions...330machine4 # [27763.260964] machine4 systemd[1]: Finished Permit User Sessions.331machine4 # [27763.262307] machine4 systemd[1]: Started Console Getty.332machine4 # [27763.262368] machine4 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0333machine4 # [27763.262390] machine4 systemd[1]: Reached target Login Prompts.334machine4 # [27763.263893] machine4 5ij0gbs03n0bda4gx2hn3sk0wqq4qg6m-merge-syncthing-config[261]: I/O warning : failed to load "/var/lib/syncthing/config.xml": No such file or directory335machine4 # [27763.341488] machine4 dbus-broker-launch[226]: Looking up NSS user entry for 'systemd-timesync'...336machine4 # [27763.342101] machine4 dbus-broker-launch[226]: NSS returned no entry for 'systemd-timesync'337machine4 # [27763.342101] machine4 dbus-broker-launch[226]: Invalid user-name in /nix/store/zpmlv369hvpj2hz60qxfc7qh0hy3kyg8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"338machine4 # [27763.342837] machine4 systemd[1]: Started D-Bus System Message Bus.339machine4 # [27763.351155] machine4 dbus-broker-launch[226]: Ready340machine2 # [27763.213335] machine2 nsncd[223]: Sep 04 15:09:43.199 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"341machine2 # [27763.236546] machine2 systemd[1]: Started Syncthing service.342machine2 # [27763.252762] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.343machine2 # [27763.253788] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd).344machine2 # [27763.254271] machine2 systemd[1]: Reached target Host and Network Name Lookups.345machine2 # [27763.254443] machine2 systemd[1]: Reached target User and Group Name Lookups.346machine2 # [27763.255369] machine2 systemd[1]: Starting Syncthing configuration updater...347machine2 # [27763.256963] machine2 systemd[1]: Starting User Login Management...348machine2 # [27763.258066] machine2 systemd[1]: Starting Permit User Sessions...349machine2 # [27763.269504] machine2 systemd[1]: Finished Permit User Sessions.350machine2 # [27763.269942] machine2 3v2gcl3zh4p309hpn3jmrmnbd3i8jgpc-merge-syncthing-config[256]: I/O warning : failed to load "/var/lib/syncthing/config.xml": No such file or directory351machine2 # [27763.270747] machine2 systemd[1]: Started Console Getty.352machine2 # [27763.270788] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0353machine2 # [27763.270809] machine2 systemd[1]: Reached target Login Prompts.354machine2 # [27763.316444] machine2 dbus-broker-launch[225]: Looking up NSS user entry for 'systemd-timesync'...355machine2 # [27763.316942] machine2 dbus-broker-launch[225]: NSS returned no entry for 'systemd-timesync'356machine2 # [27763.316942] machine2 dbus-broker-launch[225]: Invalid user-name in /nix/store/zpmlv369hvpj2hz60qxfc7qh0hy3kyg8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"357machine2 # [27763.317329] machine2 systemd[1]: Started D-Bus System Message Bus.358machine2 # [27763.324326] machine2 dbus-broker-launch[225]: Ready359machine3 # [27763.207328] machine3 nsncd[224]: Sep 04 15:09:43.193 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"360machine3 # [27763.207508] machine3 systemd[1]: Started Name Service Cache Daemon (nsncd).361machine3 # [27763.207575] machine3 systemd[1]: Reached target Host and Network Name Lookups.362machine3 # [27763.207632] machine3 systemd[1]: Reached target User and Group Name Lookups.363machine3 # [27763.237094] machine3 systemd[1]: Starting User Login Management...364machine3 # [27763.238015] machine3 systemd[1]: Starting Permit User Sessions...365machine3 # [27763.248951] machine3 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.366machine3 # [27763.250170] machine3 systemd[1]: Finished Permit User Sessions.367machine3 # [27763.251926] machine3 systemd[1]: Started Console Getty.368machine3 # [27763.251973] machine3 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0369machine3 # [27763.251988] machine3 systemd[1]: Reached target Login Prompts.370machine3 # [27763.258645] machine3 systemd[1]: Started Syncthing service.371machine3 # [27763.259852] machine3 systemd[1]: Starting Syncthing configuration updater...372machine3 # [27763.274875] machine3 ll0dmb62y9fr0a31la7ym3vpxmi4w0a9-merge-syncthing-config[261]: I/O warning : failed to load "/var/lib/syncthing/config.xml": No such file or directory373machine3 # [27763.333656] machine3 dbus-broker-launch[226]: Looking up NSS user entry for 'systemd-timesync'...374machine3 # [27763.334505] machine3 dbus-broker-launch[226]: NSS returned no entry for 'systemd-timesync'375machine3 # [27763.334505] machine3 dbus-broker-launch[226]: Invalid user-name in /nix/store/zpmlv369hvpj2hz60qxfc7qh0hy3kyg8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"376machine3 # [27763.334984] machine3 systemd[1]: Started D-Bus System Message Bus.377machine3 # [27763.343568] machine3 dbus-broker-launch[226]: Ready378machine1 # [27763.720764] machine1 systemd-logind[249]: New seat seat0.379machine1 # [27763.720990] machine1 systemd[1]: Started User Login Management.380machine1 # [27763.741909] machine1 systemd[1]: Starting linger-users.service...381machine1 # [27763.754613] machine1 systemd[1]: linger-users.service: Deactivated successfully.382machine1 # [27763.754820] machine1 systemd[1]: Finished linger-users.service.383machine1 # [27763.792097] machine1 syncthing[236]: 2026-09-04 15:09:43 INF syncthing v2.1.3 "Hafnium Hornet" (go1.26.7 linux-arm64) nix@nix 1980-01-01 00:00:00 UTC [noupgrade, stnoupgrade] (log.pkg=main)384machine1 # [27763.802333] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Default config saved; edit to taste (with Syncthing stopped) or use the GUI (path=/var/lib/syncthing/config.xml log.pkg=syncthing)385machine1 # [27763.802333] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Archiving a copy of old config file format (path=/var/lib/syncthing/config.xml.v0 log.pkg=syncthing)386machine1 # [27763.807156] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Calculated our device ID (device=J6AWUPP-QMJI5TX-2MMG5ZP-KSCN2WV-RZKIUPM-LIEUQGD-APC6J4X-K74PWAC log.pkg=syncthing)387machine1 # [27763.808512] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Overall rate limit in use (send="is unlimited" recv="is unlimited" log.pkg=connections)388machine1 # [27763.809565] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="global discovery server https://discovery-lookup.syncthing.net/v2/?noannounce" log.pkg=discover)389machine1 # [27763.809763] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="global discovery server https://discovery-announce-v4.syncthing.net/v2/?nolookup" log.pkg=discover)390machine1 # [27763.809763] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="global discovery server https://discovery-announce-v6.syncthing.net/v2/?nolookup" log.pkg=discover)391machine1 # [27763.809861] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Relay listener starting (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)392machine1 # [27763.809861] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Creating new HTTPS certificate (log.pkg=api)393machine1 # [27763.809861] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="IPv4 local broadcast discovery on port 21027" log.pkg=discover)394machine1 # [27763.810929] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="IPv6 local multicast discovery on address [ff12::8384]:21027" log.pkg=discover)395machine1 # [27763.810929] machine1 syncthing[236]: 2026-09-04 15:09:43 INF QUIC listener starting (address="[::]:22000" log.pkg=connections)396machine1 # [27763.810929] machine1 syncthing[236]: 2026-09-04 15:09:43 INF TCP listener starting (address="[::]:22000" log.pkg=connections)397machine1 # [27763.811041] machine1 syncthing[236]: 2026-09-04 15:09:43 INF GUI and API listening (address=127.0.0.1:8384 log.pkg=api)398machine1 # [27763.811041] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Access the GUI via the following URL: http://127.0.0.1:8384/ (log.pkg=api)399machine1 # [27763.811041] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Loaded configuration (name=machine1 log.pkg=syncthing)400machine1 # [27763.811702] machine1 systemd-resolved[120]: Switching to fallback DNS server 1.1.1.1#one.one.one.one.401machine1 # [27763.817573] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Relay listener shutting down (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)402machine1 # [27763.817573] machine1 syncthing[236]: 2026-09-04 15:09:43 WRN Service failed (error="Get \"https://relays.syncthing.net/endpoint\": dial tcp: lookup relays.syncthing.net: no such host" supervisor=listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint service=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)403machine1 # [27763.817573] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Relay listener starting (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)404machine1 # [27763.821450] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Relay listener shutting down (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)405machine1 # [27763.821450] machine1 syncthing[236]: 2026-09-04 15:09:43 WRN Service failed (error="Get \"https://relays.syncthing.net/endpoint\": dial tcp: lookup relays.syncthing.net: no such host" supervisor=listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint service=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)406machine1 # [27763.821563] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Relay listener starting (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)407machine1 # [27763.822899] machine1 syncthing[236]: 2026-09-04 15:09:43 INF Relay listener shutting down (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)408machine1 # [27763.822926] machine1 syncthing[236]: 2026-09-04 15:09:43 WRN Service failed (error="Get \"https://relays.syncthing.net/endpoint\": dial tcp: lookup relays.syncthing.net: no such host" supervisor=listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint service=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)409machine4 # [27763.731090] machine4 systemd-logind[248]: New seat seat0.410machine4 # [27763.731294] machine4 systemd[1]: Started User Login Management.411machine4 # [27763.742995] machine4 systemd[1]: Starting linger-users.service...412machine4 # [27763.756225] machine4 systemd[1]: linger-users.service: Deactivated successfully.413machine4 # [27763.756395] machine4 systemd[1]: Finished linger-users.service.414machine4 # [27763.790084] machine4 syncthing[236]: 2026-09-04 15:09:43 INF syncthing v2.1.3 "Hafnium Hornet" (go1.26.7 linux-arm64) nix@nix 1980-01-01 00:00:00 UTC [noupgrade, stnoupgrade] (log.pkg=main)415machine4 # [27763.802441] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Default config saved; edit to taste (with Syncthing stopped) or use the GUI (path=/var/lib/syncthing/config.xml log.pkg=syncthing)416machine4 # [27763.802441] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Archiving a copy of old config file format (path=/var/lib/syncthing/config.xml.v0 log.pkg=syncthing)417machine4 # [27763.807124] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Calculated our device ID (device=HLWU6C2-VXRCDEX-ZPVY5JL-F63577P-JTNMKJ6-LVRXP2U-AYFH6JG-SPJ7OAF log.pkg=syncthing)418machine4 # [27763.808905] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Overall rate limit in use (send="is unlimited" recv="is unlimited" log.pkg=connections)419machine4 # [27763.809415] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="global discovery server https://discovery-lookup.syncthing.net/v2/?noannounce" log.pkg=discover)420machine3 # [27763.710782] machine3 systemd-logind[245]: New seat seat0.421machine4 # [27763.812675] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="global discovery server https://discovery-announce-v4.syncthing.net/v2/?nolookup" log.pkg=discover)422machine3 # [27763.711023] machine3 systemd[1]: Started User Login Management.423machine4 # [27763.812675] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="global discovery server https://discovery-announce-v6.syncthing.net/v2/?nolookup" log.pkg=discover)424machine3 # [27763.742036] machine3 systemd[1]: Starting linger-users.service...425machine4 # [27763.812728] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="IPv4 local broadcast discovery on port 21027" log.pkg=discover)426machine3 # [27763.755783] machine3 systemd[1]: linger-users.service: Deactivated successfully.427machine4 # [27763.812756] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="IPv6 local multicast discovery on address [ff12::8384]:21027" log.pkg=discover)428machine3 # [27763.755885] machine3 systemd[1]: Finished linger-users.service.429machine4 # [27763.813363] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Relay listener starting (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)430machine3 # [27763.790005] machine3 syncthing[256]: 2026-09-04 15:09:43 INF syncthing v2.1.3 "Hafnium Hornet" (go1.26.7 linux-arm64) nix@nix 1980-01-01 00:00:00 UTC [noupgrade, stnoupgrade] (log.pkg=main)431machine4 # [27763.813425] machine4 syncthing[236]: 2026-09-04 15:09:43 INF TCP listener starting (address="[::]:22000" log.pkg=connections)432machine3 # [27763.802704] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Default config saved; edit to taste (with Syncthing stopped) or use the GUI (path=/var/lib/syncthing/config.xml log.pkg=syncthing)433machine4 # [27763.813626] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Creating new HTTPS certificate (log.pkg=api)434machine3 # [27763.802704] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Archiving a copy of old config file format (path=/var/lib/syncthing/config.xml.v0 log.pkg=syncthing)435machine4 # [27763.813735] machine4 syncthing[236]: 2026-09-04 15:09:43 INF QUIC listener starting (address="[::]:22000" log.pkg=connections)436machine3 # [27763.807264] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Calculated our device ID (device=PAVQZAT-UXEYYVJ-VK4QPPY-PU77FJS-I6PVWQ3-67G3VOT-PWT7CTP-AGS34QL log.pkg=syncthing)437machine4 # [27763.814930] machine4 syncthing[236]: 2026-09-04 15:09:43 INF GUI and API listening (address=127.0.0.1:8384 log.pkg=api)438machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Overall rate limit in use (send="is unlimited" recv="is unlimited" log.pkg=connections)439machine4 # [27763.814930] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Access the GUI via the following URL: http://127.0.0.1:8384/ (log.pkg=api)440machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="global discovery server https://discovery-lookup.syncthing.net/v2/?noannounce" log.pkg=discover)441machine4 # [27763.815112] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Loaded configuration (name=machine4 log.pkg=syncthing)442machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="global discovery server https://discovery-announce-v4.syncthing.net/v2/?nolookup" log.pkg=discover)443machine4 # [27763.815305] machine4 systemd-resolved[121]: Switching to fallback DNS server 1.1.1.1#one.one.one.one.444machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="global discovery server https://discovery-announce-v6.syncthing.net/v2/?nolookup" log.pkg=discover)445machine4 # [27763.817097] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Relay listener shutting down (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)446machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="IPv4 local broadcast discovery on port 21027" log.pkg=discover)447machine4 # [27763.817136] machine4 syncthing[236]: 2026-09-04 15:09:43 WRN Service failed (error="Get \"https://relays.syncthing.net/endpoint\": dial tcp: lookup relays.syncthing.net: no such host" supervisor=listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint service=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)448machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="IPv6 local multicast discovery on address [ff12::8384]:21027" log.pkg=discover)449machine4 # [27763.817136] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Relay listener starting (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)450machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Creating new HTTPS certificate (log.pkg=api)451machine4 # [27763.819093] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Relay listener shutting down (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)452machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF TCP listener starting (address="[::]:22000" log.pkg=connections)453machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Relay listener starting (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)454machine4 # [27763.819119] machine4 syncthing[236]: 2026-09-04 15:09:43 WRN Service failed (error="Get \"https://relays.syncthing.net/endpoint\": dial tcp: lookup relays.syncthing.net: no such host" supervisor=listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint service=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)455machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF QUIC listener starting (address="[::]:22000" log.pkg=connections)456machine4 # [27763.819142] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Relay listener starting (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)457machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF GUI and API listening (address=127.0.0.1:8384 log.pkg=api)458machine4 # [27763.820492] machine4 syncthing[236]: 2026-09-04 15:09:43 INF Relay listener shutting down (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)459machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Access the GUI via the following URL: http://127.0.0.1:8384/ (log.pkg=api)460machine4 # [27763.820525] machine4 syncthing[236]: 2026-09-04 15:09:43 WRN Service failed (error="Get \"https://relays.syncthing.net/endpoint\": dial tcp: lookup relays.syncthing.net: no such host" supervisor=listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint service=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)461machine3 # [27763.810959] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Loaded configuration (name=machine3 log.pkg=syncthing)462machine3 # [27763.811535] machine3 systemd-resolved[120]: Switching to fallback DNS server 1.1.1.1#one.one.one.one.463machine3 # [27763.812850] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Relay listener shutting down (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)464machine3 # [27763.812934] machine3 syncthing[256]: 2026-09-04 15:09:43 WRN Service failed (error="Get \"https://relays.syncthing.net/endpoint\": dial tcp: lookup relays.syncthing.net: no such host" supervisor=listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint service=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)465machine3 # [27763.812963] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Relay listener starting (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)466machine3 # [27763.814637] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Relay listener shutting down (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)467machine3 # [27763.814637] machine3 syncthing[256]: 2026-09-04 15:09:43 WRN Service failed (error="Get \"https://relays.syncthing.net/endpoint\": dial tcp: lookup relays.syncthing.net: no such host" supervisor=listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint service=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)468machine3 # [27763.814637] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Relay listener starting (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)469machine3 # [27763.816217] machine3 syncthing[256]: 2026-09-04 15:09:43 INF Relay listener shutting down (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)470machine3 # [27763.816391] machine3 syncthing[256]: 2026-09-04 15:09:43 WRN Service failed (error="Get \"https://relays.syncthing.net/endpoint\": dial tcp: lookup relays.syncthing.net: no such host" supervisor=listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint service=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)471machine2 # [27763.734286] machine2 systemd-logind[247]: New seat seat0.472machine2 # [27763.734438] machine2 systemd[1]: Started User Login Management.473machine2 # [27763.741335] machine2 systemd[1]: Starting linger-users.service...474machine2 # [27763.755287] machine2 systemd[1]: linger-users.service: Deactivated successfully.475machine2 # [27763.755513] machine2 systemd[1]: Finished linger-users.service.476machine2 # [27763.789529] machine2 syncthing[235]: 2026-09-04 15:09:43 INF syncthing v2.1.3 "Hafnium Hornet" (go1.26.7 linux-arm64) nix@nix 1980-01-01 00:00:00 UTC [noupgrade, stnoupgrade] (log.pkg=main)477machine2 # [27763.802339] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Default config saved; edit to taste (with Syncthing stopped) or use the GUI (path=/var/lib/syncthing/config.xml log.pkg=syncthing)478machine2 # [27763.802339] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Archiving a copy of old config file format (path=/var/lib/syncthing/config.xml.v0 log.pkg=syncthing)479machine2 # [27763.807084] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Calculated our device ID (device=PR4ZCBE-P7TPGBX-DZREABT-WYUUTBS-YJQ4S5U-ALGEP6V-JC32HGD-KAWVDAR log.pkg=syncthing)480machine2 # [27763.808921] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Overall rate limit in use (send="is unlimited" recv="is unlimited" log.pkg=connections)481machine2 # [27763.809194] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Relay listener starting (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)482machine2 # [27763.809378] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="global discovery server https://discovery-lookup.syncthing.net/v2/?noannounce" log.pkg=discover)483machine2 # [27763.809551] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="global discovery server https://discovery-announce-v4.syncthing.net/v2/?nolookup" log.pkg=discover)484machine2 # [27763.809551] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="global discovery server https://discovery-announce-v6.syncthing.net/v2/?nolookup" log.pkg=discover)485machine2 # [27763.809598] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="IPv4 local broadcast discovery on port 21027" log.pkg=discover)486machine2 # [27763.809642] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Using discovery mechanism (identity="IPv6 local multicast discovery on address [ff12::8384]:21027" log.pkg=discover)487machine2 # [27763.809642] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Creating new HTTPS certificate (log.pkg=api)488machine2 # [27763.809995] machine2 syncthing[235]: 2026-09-04 15:09:43 INF QUIC listener starting (address="[::]:22000" log.pkg=connections)489machine2 # [27763.810403] machine2 syncthing[235]: 2026-09-04 15:09:43 INF TCP listener starting (address="[::]:22000" log.pkg=connections)490machine2 # [27763.811440] machine2 syncthing[235]: 2026-09-04 15:09:43 INF GUI and API listening (address=127.0.0.1:8384 log.pkg=api)491machine2 # [27763.811440] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Access the GUI via the following URL: http://127.0.0.1:8384/ (log.pkg=api)492machine2 # [27763.811725] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Loaded configuration (name=machine2 log.pkg=syncthing)493machine2 # [27763.811917] machine2 systemd-resolved[118]: Switching to fallback DNS server 1.1.1.1#one.one.one.one.494machine2 # [27763.813603] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Relay listener shutting down (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)495machine2 # [27763.813642] machine2 syncthing[235]: 2026-09-04 15:09:43 WRN Service failed (error="Get \"https://relays.syncthing.net/endpoint\": dial tcp: lookup relays.syncthing.net: no such host" supervisor=listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint service=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)496machine2 # [27763.813664] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Relay listener starting (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)497machine2 # [27763.815490] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Relay listener shutting down (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)498machine2 # [27763.815490] machine2 syncthing[235]: 2026-09-04 15:09:43 WRN Service failed (error="Get \"https://relays.syncthing.net/endpoint\": dial tcp: lookup relays.syncthing.net: no such host" supervisor=listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint service=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)499machine2 # [27763.815563] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Relay listener starting (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)500machine2 # [27763.817086] machine2 syncthing[235]: 2026-09-04 15:09:43 INF Relay listener shutting down (id=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)501machine2 # [27763.817126] machine2 syncthing[235]: 2026-09-04 15:09:43 WRN Service failed (error="Get \"https://relays.syncthing.net/endpoint\": dial tcp: lookup relays.syncthing.net: no such host" supervisor=listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint service=dynamic+https://relays.syncthing.net/endpoint log.pkg=connections)502machine2 # [27764.160182] machine2 systemd-networkd[217]: eth1: Gained IPv6LL503machine2 # [27764.264174] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Measured hashing performance (perf="1674.88 MB/s" log.pkg=syncthing)504machine2 # [27764.300891] machine2 3v2gcl3zh4p309hpn3jmrmnbd3i8jgpc-merge-syncthing-config[246]: Syncthing is not doing a database migration (anymore).505machine2 # [27764.323628] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Established secure connection (device=J6AWUPP connection.local=192.168.1.2:22000 connection.remote=192.168.1.1:22000 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7CD5TSUERFT90OSBFTKS log.pkg=connections)506machine2 # [27764.323628] machine2 syncthing[235]: 2026-09-04 15:09:44 INF New device connection (device=J6AWUPP address=192.168.1.1:22000 remote.name=machine1 remote.client=syncthing remote.version=v2.1.3 log.pkg=model)507machine2 # [27764.325854] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Established secure connection (device=J6AWUPP connection.local=192.168.1.2:58650 connection.remote=192.168.1.1:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7CN7N02PCQIN6AMB55IU log.pkg=connections)508machine2 # [27764.325854] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Additional device connection (device=J6AWUPP address=192.168.1.1:22000 count=1 log.pkg=model)509machine2 # [27764.338069] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Established secure connection (device=J6AWUPP connection.local=192.168.1.2:22000 connection.remote=192.168.1.1:46850 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7E71IH403ROJME32SLDE log.pkg=connections)510machine2 # [27764.338069] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Additional device connection (device=J6AWUPP address=192.168.1.1:46850 count=2 log.pkg=model)511machine2 # [27764.342477] machine2 syncthing[235]: 2026-09-04 15:09:44 WRN Connection rejected (device=HLWU6C2 address=192.168.1.4:22000 type=tcp-server error="unknown device" log.pkg=connections)512machine2 # [27764.350573] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Established secure connection (device=PAVQZAT connection.local=192.168.1.2:22000 connection.remote=192.168.1.3:22000 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7FMQD5K28RHQMAN1BUVM log.pkg=connections)513machine2 # [27764.350573] machine2 syncthing[235]: 2026-09-04 15:09:44 INF New device connection (device=PAVQZAT address=192.168.1.3:22000 remote.name=machine3 remote.client=syncthing remote.version=v2.1.3 log.pkg=model)514machine2 # [27764.359617] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Established secure connection (device=PAVQZAT connection.local=192.168.1.2:54204 connection.remote=192.168.1.3:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7GNU3NCS6EEPMR8B8LHS log.pkg=connections)515machine2 # [27764.359617] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Additional device connection (device=PAVQZAT address=192.168.1.3:22000 count=1 log.pkg=model)516machine2 # [27764.361789] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Established secure connection (device=PAVQZAT connection.local=192.168.1.2:22000 connection.remote=192.168.1.3:43224 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7GV5NMM0BNEB5UFO1CH0 log.pkg=connections)517machine2 # [27764.361789] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Additional device connection (device=PAVQZAT address=192.168.1.3:43224 count=2 log.pkg=model)518machine2 # [27764.371502] machine2 syncthing[235]: 2026-09-04 15:09:44 WRN Failed to exchange Hello messages (device=HLWU6C2 address=192.168.1.4:22000 error=EOF log.pkg=connections)519machine2 # [27764.393248] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Adding folder (folder.id=documents folder.type=sendreceive log.pkg=model)520machine2 # [27764.394533] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Ready to synchronize (folder.id=documents folder.type=sendreceive log.pkg=model)521machine2 # [27764.402268] machine2 syncthing[235]: 2026-09-04 15:09:44 INF Completed initial scan (folder.id=documents folder.type=sendreceive log.pkg=model)522machine3: (finished: waiting for unit syncthing.service, in 3.16 seconds)523machine4 # [27764.263885] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Measured hashing performance (perf="1675.05 MB/s" log.pkg=syncthing)524machine4: waiting for unit syncthing.service525machine4 # [27764.294576] machine4 5ij0gbs03n0bda4gx2hn3sk0wqq4qg6m-merge-syncthing-config[247]: Syncthing is not doing a database migration (anymore).526machine4 # [27764.323055] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Established secure connection (device=J6AWUPP connection.local=192.168.1.4:22000 connection.remote=192.168.1.1:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7C7BFPO4JGQ6EJQUVU6K log.pkg=connections)527machine4 # [27764.323055] machine4 syncthing[236]: 2026-09-04 15:09:44 INF New device connection (device=J6AWUPP address=192.168.1.1:22000 remote.name="" remote.client=syncthing remote.version=v2.1.3 log.pkg=model)528machine4 # [27764.342587] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Established secure connection (device=PR4ZCBE connection.local=192.168.1.4:22000 connection.remote=192.168.1.2:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7ELB506GDICK3IK5LDEC log.pkg=connections)529machine4 # [27764.342587] machine4 syncthing[236]: 2026-09-04 15:09:44 INF New device connection (device=PR4ZCBE address=192.168.1.2:22000 remote.name="" remote.client=syncthing remote.version=v2.1.3 log.pkg=model)530machine4 # [27764.356185] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Established secure connection (device=PAVQZAT connection.local=192.168.1.4:22000 connection.remote=192.168.1.3:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7G8T0SUM8NUHBFS0R028 log.pkg=connections)531machine4 # [27764.356185] machine4 syncthing[236]: 2026-09-04 15:09:44 INF New device connection (device=PAVQZAT address=192.168.1.3:22000 remote.name="" remote.client=syncthing remote.version=v2.1.3 log.pkg=model)532machine4 # [27764.389728] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Adding folder (folder.id=documents folder.type=sendreceive log.pkg=model)533machine4 # [27764.391251] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Ready to synchronize (folder.id=documents folder.type=sendreceive log.pkg=model)534machine4 # [27764.397360] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Completed initial scan (folder.id=documents folder.type=sendreceive log.pkg=model)535machine4 # [27764.415720] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Adding folder (folder.id=partly_shared folder.type=sendreceive log.pkg=model)536machine4 # [27764.416558] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Ready to synchronize (folder.id=partly_shared folder.type=sendreceive log.pkg=model)537machine4 # [27764.426798] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Completed initial scan (folder.id=partly_shared folder.type=sendreceive log.pkg=model)538machine4 # [27764.442016] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Adding folder (folder.id=pictures folder.type=sendreceive log.pkg=model)539machine4 # [27764.442832] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Ready to synchronize (folder.id=pictures folder.type=sendreceive log.pkg=model)540machine4 # [27764.453036] machine4 syncthing[236]: 2026-09-04 15:09:44 INF Completed initial scan (folder.id=pictures folder.type=sendreceive log.pkg=model)541machine4 # [27764.486456] machine4 systemd[1]: Finished Syncthing configuration updater.542machine4 # [27764.487240] machine4 systemd[1]: Reached target Multi-User System.543machine4 # [27764.488274] machine4 systemd[1]: Startup finished in 2.631s.544machine4: (finished: waiting for unit syncthing.service, in 0.01 seconds)545machine1: waiting for TCP port 8384 on localhost546Connection to localhost (127.0.0.1) 8384 port [tcp/*] succeeded!547machine1: (finished: waiting for TCP port 8384 on localhost, in 0.01 seconds)548machine2: waiting for TCP port 8384 on localhost549Connection to localhost (127.0.0.1) 8384 port [tcp/*] succeeded!550machine2: (finished: waiting for TCP port 8384 on localhost, in 0.01 seconds)551machine3: waiting for TCP port 8384 on localhost552machine3 # [27764.264315] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Measured hashing performance (perf="1675.68 MB/s" log.pkg=syncthing)553machine3 # [27764.304424] machine3 ll0dmb62y9fr0a31la7ym3vpxmi4w0a9-merge-syncthing-config[257]: Syncthing is not doing a database migration (anymore).554machine3 # [27764.333319] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Established secure connection (device=J6AWUPP connection.local=192.168.1.3:22000 connection.remote=192.168.1.1:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7DK4JSSK7JGUKS7TJKNU log.pkg=connections)555machine1 # [27764.263606] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Measured hashing performance (perf="1678.33 MB/s" log.pkg=syncthing)556machine3 # [27764.333319] machine3 syncthing[256]: 2026-09-04 15:09:44 INF New device connection (device=J6AWUPP address=192.168.1.1:22000 remote.name=machine1 remote.client=syncthing remote.version=v2.1.3 log.pkg=model)557machine1 # [27764.276718] machine1 cfkxq629vg44wbbvajvr4k0ws7fvj6w1-merge-syncthing-config[237]: Syncthing is not doing a database migration (anymore).558machine3 # [27764.340798] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Established secure connection (device=J6AWUPP connection.local=192.168.1.3:22000 connection.remote=192.168.1.1:37336 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7EGIMG07S3MURVG587D8 log.pkg=connections)559machine1 # [27764.323446] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Established secure connection (device=PR4ZCBE connection.local=192.168.1.1:22000 connection.remote=192.168.1.2:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7CD5TSUHD84K2MKUMSDO log.pkg=connections)560machine3 # [27764.340798] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Additional device connection (device=J6AWUPP address=192.168.1.1:37336 count=1 log.pkg=model)561machine1 # [27764.323581] machine1 syncthing[236]: 2026-09-04 15:09:44 INF New device connection (device=PR4ZCBE address=192.168.1.2:22000 remote.name=machine2 remote.client=syncthing remote.version=v2.1.3 log.pkg=model)562machine3 # [27764.349430] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Established secure connection (device=J6AWUPP connection.local=192.168.1.3:43298 connection.remote=192.168.1.1:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7FIAOCIA9J9KSSV011HM log.pkg=connections)563machine1 # [27764.323926] machine1 syncthing[236]: 2026-09-04 15:09:44 WRN Connection rejected (device=HLWU6C2 address=192.168.1.4:22000 type=tcp-server error="unknown device" log.pkg=connections)564machine3 # [27764.349430] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Additional device connection (device=J6AWUPP address=192.168.1.1:22000 count=2 log.pkg=model)565machine1 # [27764.326765] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Established secure connection (device=PR4ZCBE connection.local=192.168.1.1:22000 connection.remote=192.168.1.2:58650 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7CN7N02N5MFFA4SUQHHQ log.pkg=connections)566machine1 # [27764.326765] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Additional device connection (device=PR4ZCBE address=192.168.1.2:58650 count=1 log.pkg=model)567machine1 # [27764.329746] machine1 syncthing[236]: 2026-09-04 15:09:44 WRN Failed to exchange Hello messages (device=PR4ZCBE address="[fe80::841a:97ff:feca:9851%eth1]:22000" error="write tcp [2001:db8:1::1]:22000->[fe80::841a:97ff:feca:9851%eth1]:22000: write: connection reset by peer" log.pkg=connections)568machine3 # [27764.350657] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Established secure connection (device=PR4ZCBE connection.local=192.168.1.3:22000 connection.remote=192.168.1.2:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7FMQD5KVPCBKDL3M0FA4 log.pkg=connections)569machine1 # [27764.333242] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Established secure connection (device=PAVQZAT connection.local=192.168.1.1:22000 connection.remote=192.168.1.3:22000 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7DK4JSSN4V338A848EKK log.pkg=connections)570machine3 # [27764.350657] machine3 syncthing[256]: 2026-09-04 15:09:44 INF New device connection (device=PR4ZCBE address=192.168.1.2:22000 remote.name=machine2 remote.client=syncthing remote.version=v2.1.3 log.pkg=model)571machine1 # [27764.333242] machine1 syncthing[236]: 2026-09-04 15:09:44 INF New device connection (device=PAVQZAT address=192.168.1.3:22000 remote.name=machine3 remote.client=syncthing remote.version=v2.1.3 log.pkg=model)572machine3 # [27764.356278] machine3 syncthing[256]: 2026-09-04 15:09:44 WRN Connection rejected (device=HLWU6C2 address=192.168.1.4:22000 type=tcp-server error="unknown device" log.pkg=connections)573machine1 # [27764.338217] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Established secure connection (device=PR4ZCBE connection.local=192.168.1.1:46850 connection.remote=192.168.1.2:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7E71IH4429JP19LT82TK log.pkg=connections)574machine3 # [27764.359419] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Established secure connection (device=PR4ZCBE connection.local=192.168.1.3:22000 connection.remote=192.168.1.2:54204 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7GNU3NC0MOOJRR360KJC log.pkg=connections)575machine1 # [27764.338217] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Additional device connection (device=PR4ZCBE address=192.168.1.2:22000 count=2 log.pkg=model)576machine1 # [27764.340850] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Established secure connection (device=PAVQZAT connection.local=192.168.1.1:37336 connection.remote=192.168.1.3:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7EGIMG04ENT5JMA2T68U log.pkg=connections)577machine3 # [27764.359419] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Additional device connection (device=PR4ZCBE address=192.168.1.2:54204 count=1 log.pkg=model)578machine1 # [27764.340850] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Additional device connection (device=PAVQZAT address=192.168.1.3:22000 count=1 log.pkg=model)579machine1 # [27764.349438] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Established secure connection (device=PAVQZAT connection.local=192.168.1.1:22000 connection.remote=192.168.1.3:43298 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7FIAOCIAPIU85NRQD7PG log.pkg=connections)580machine3 # [27764.361759] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Established secure connection (device=PR4ZCBE connection.local=192.168.1.3:43224 connection.remote=192.168.1.2:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QT7GV5NMM2G0J4A195C5EI log.pkg=connections)581machine1 # [27764.349438] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Additional device connection (device=PAVQZAT address=192.168.1.3:43298 count=2 log.pkg=model)582machine3 # [27764.361759] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Additional device connection (device=PR4ZCBE address=192.168.1.2:22000 count=2 log.pkg=model)583machine3 # [27764.380464] machine3 syncthing[256]: 2026-09-04 15:09:44 WRN Failed to exchange Hello messages (device=HLWU6C2 address=192.168.1.4:22000 error=EOF log.pkg=connections)584machine3 # [27764.403327] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Adding folder (folder.id=documents folder.type=sendreceive log.pkg=model)585machine3 # [27764.404187] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Ready to synchronize (folder.id=documents folder.type=sendreceive log.pkg=model)586machine3 # [27764.412756] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Completed initial scan (folder.id=documents folder.type=sendreceive log.pkg=model)587Connection to localhost (127.0.0.1) 8384 port [tcp/*] succeeded!588machine3 # [27764.428449] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Adding folder (folder.id=pictures folder.type=sendreceive log.pkg=model)589machine3 # [27764.429720] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Ready to synchronize (folder.id=pictures folder.type=sendreceive log.pkg=model)590machine3 # [27764.435193] machine3 syncthing[256]: 2026-09-04 15:09:44 INF Completed initial scan (folder.id=pictures folder.type=sendreceive log.pkg=model)591machine3 # [27764.468316] machine3 systemd[1]: Finished Syncthing configuration updater.592machine3 # [27764.468733] machine3 systemd[1]: Reached target Multi-User System.593machine3 # [27764.484245] machine3 systemd-networkd[218]: eth1: Gained IPv6LL594machine3 # [27764.488274] machine3 systemd[1]: Startup finished in 2.634s.595machine1 # [27764.351652] machine1 syncthing[236]: 2026-09-04 15:09:44 WRN Failed to exchange Hello messages (device=HLWU6C2 address=192.168.1.4:22000 error=EOF log.pkg=connections)596machine1 # [27764.375122] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Adding folder (folder.id=documents folder.type=sendreceive log.pkg=model)597machine1 # [27764.375993] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Ready to synchronize (folder.id=documents folder.type=sendreceive log.pkg=model)598machine1 # [27764.383816] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Completed initial scan (folder.id=documents folder.type=sendreceive log.pkg=model)599machine1 # [27764.400172] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Adding folder (folder.id=partly_shared folder.type=sendreceive log.pkg=model)600machine1 # [27764.401254] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Ready to synchronize (folder.id=partly_shared folder.type=sendreceive log.pkg=model)601machine1 # [27764.406440] machine1 syncthing[236]: 2026-09-04 15:09:44 INF Completed initial scan (folder.id=partly_shared folder.type=sendreceive log.pkg=model)602machine1 # [27764.434381] machine1 systemd[1]: Finished Syncthing configuration updater.603machine1 # [27764.434844] machine1 systemd[1]: Reached target Multi-User System.604machine1 # [27764.435292] machine1 systemd[1]: Startup finished in 2.553s.605machine3: (finished: waiting for TCP port 8384 on localhost, in 0.01 seconds)606machine4: waiting for TCP port 8384 on localhost607Connection to localhost (127.0.0.1) 8384 port [tcp/*] succeeded!608machine4: (finished: waiting for TCP port 8384 on localhost, in 0.01 seconds)609machine1: waiting for TCP port 22000 on localhost610Connection to localhost (::1) 22000 port [tcp/snapenetio] succeeded!611machine1: (finished: waiting for TCP port 22000 on localhost, in 0.01 seconds)612machine2: waiting for TCP port 22000 on localhost613Connection to localhost (::1) 22000 port [tcp/snapenetio] succeeded!614machine2: (finished: waiting for TCP port 22000 on localhost, in 0.01 seconds)615machine3: waiting for TCP port 22000 on localhost616Connection to localhost (::1) 22000 port [tcp/snapenetio] succeeded!617machine3: (finished: waiting for TCP port 22000 on localhost, in 0.01 seconds)618machine4: waiting for TCP port 22000 on localhost619Connection to localhost (::1) 22000 port [tcp/snapenetio] succeeded!620machine4: (finished: waiting for TCP port 22000 on localhost, in 0.01 seconds)621machine1: waiting for file '/var/lib/syncthing/documents'622machine1: (finished: waiting for file '/var/lib/syncthing/documents', in 0.01 seconds)623machine2: waiting for file '/var/lib/syncthing/documents'624machine2: (finished: waiting for file '/var/lib/syncthing/documents', in 0.01 seconds)625machine3: waiting for file '/var/lib/syncthing/documents'626machine3: (finished: waiting for file '/var/lib/syncthing/documents', in 0.01 seconds)627machine4: waiting for file '/var/lib/syncthing/documents'628machine4: (finished: waiting for file '/var/lib/syncthing/documents', in 0.01 seconds)629machine1: waiting for file '/var/lib/syncthing/music'630machine1: (finished: waiting for file '/var/lib/syncthing/music', in 0.01 seconds)631machine4: waiting for file '/var/lib/syncthing/music'632machine4: (finished: waiting for file '/var/lib/syncthing/music', in 0.01 seconds)633machine2: must fail: test -e /var/lib/syncthing/music634machine2: (finished: must fail: test -e /var/lib/syncthing/music, in 0.01 seconds)635machine3: must fail: test -e /var/lib/syncthing/music636machine3: (finished: must fail: test -e /var/lib/syncthing/music, in 0.01 seconds)637machine3: waiting for file '/var/lib/syncthing/pictures'638machine3: (finished: waiting for file '/var/lib/syncthing/pictures', in 0.01 seconds)639machine4: waiting for file '/var/lib/syncthing/pictures'640machine4: (finished: waiting for file '/var/lib/syncthing/pictures', in 0.01 seconds)641machine1: must fail: test -e /var/lib/syncthing/pictures642machine1: (finished: must fail: test -e /var/lib/syncthing/pictures, in 0.01 seconds)643machine2: must fail: test -e /var/lib/syncthing/pictures644machine2: (finished: must fail: test -e /var/lib/syncthing/pictures, in 0.01 seconds)645machine1: must succeed: echo document > /var/lib/syncthing/documents/document646machine1: (finished: must succeed: echo document > /var/lib/syncthing/documents/document, in 0.01 seconds)647machine1: must succeed: echo music > /var/lib/syncthing/music/music648machine1: (finished: must succeed: echo music > /var/lib/syncthing/music/music, in 0.01 seconds)649machine3: must succeed: echo picture > /var/lib/syncthing/pictures/picture650machine3: (finished: must succeed: echo picture > /var/lib/syncthing/pictures/picture, in 0.01 seconds)651??? Warning (UserWarning): wait_for_file(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.652 File "/nix/store/cag5izn0mcnmyi82zb3rwfs1s1afa6q5-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39653machine2: waiting for file '/var/lib/syncthing/documents/document'654machine2 # [27764.468228] machine2 systemd[1]: Finished Syncthing configuration updater.655machine2 # [27764.469774] machine2 systemd[1]: Reached target Multi-User System.656machine2 # [27764.488272] machine2 systemd[1]: Startup finished in 2.636s.657machine2 # [27764.604221] machine2 syncthing[235]: 2026-09-04 15:09:44 WRN Failed TLS handshake (address="[::1]:53816" error=EOF log.pkg=connections)658machine3 # [27764.615637] machine3 syncthing[256]: 2026-09-04 15:09:44 WRN Failed TLS handshake (address="[::1]:53818" error=EOF log.pkg=connections)659machine1 # [27764.592707] machine1 syncthing[236]: 2026-09-04 15:09:44 WRN Failed TLS handshake (address="[::1]:53806" error=EOF log.pkg=connections)660machine1 # [27764.608285] machine1 systemd-networkd[218]: eth1: Gained IPv6LL661machine4 # [27764.628169] machine4 syncthing[236]: 2026-09-04 15:09:44 WRN Failed TLS handshake (address="[::1]:53826" error=EOF log.pkg=connections)662machine4 # [27764.708222] machine4 systemd-networkd[218]: eth1: Gained IPv6LL663machine2 # [27765.363353] machine2 syncthing[235]: 2026-09-04 15:09:45 INF Peer has a new index ID (device=J6AWUPP folder.id=documents folder.type=sendreceive indexid=0x6CC42C8184F9E6D4 log.pkg=model)664machine2 # [27765.363684] machine2 syncthing[235]: 2026-09-04 15:09:45 INF Peer has a new index ID (device=PAVQZAT folder.id=documents folder.type=sendreceive indexid=0xA04672968762471C log.pkg=model)665machine2 # [27765.368248] machine2 syncthing[235]: 2026-09-04 15:09:45 INF Established secure connection (device=HLWU6C2 connection.local=192.168.1.2:22000 connection.remote=192.168.1.4:22000 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QTB8VRG3OT1816HKIUPE8Q log.pkg=connections)666machine2 # [27765.368248] machine2 syncthing[235]: 2026-09-04 15:09:45 INF New device connection (device=HLWU6C2 address=192.168.1.4:22000 remote.name=machine4 remote.client=syncthing remote.version=v2.1.3 log.pkg=model)667machine2 # [27765.379932] machine2 syncthing[235]: 2026-09-04 15:09:45 INF Established secure connection (device=HLWU6C2 connection.local=192.168.1.2:22000 connection.remote=192.168.1.4:57950 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QTBACS8BIRT75HO2G3AQJC log.pkg=connections)668machine2 # [27765.379932] machine2 syncthing[235]: 2026-09-04 15:09:45 INF Additional device connection (device=HLWU6C2 address=192.168.1.4:57950 count=1 log.pkg=model)669machine3 # [27765.362875] machine3 syncthing[256]: 2026-09-04 15:09:45 INF Peer has a new index ID (device=J6AWUPP folder.id=documents folder.type=sendreceive indexid=0x6CC42C8184F9E6D4 log.pkg=model)670machine3 # [27765.366436] machine3 syncthing[256]: 2026-09-04 15:09:45 INF Peer has a new index ID (device=PR4ZCBE folder.id=documents folder.type=sendreceive indexid=0x715EC05DCAC18E46 log.pkg=model)671machine3 # [27765.370150] machine3 syncthing[256]: 2026-09-04 15:09:45 INF Established secure connection (device=HLWU6C2 connection.local=192.168.1.3:22000 connection.remote=192.168.1.4:22000 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QTB97TLPEBD2N0SC8SADMI log.pkg=connections)672machine3 # [27765.370150] machine3 syncthing[256]: 2026-09-04 15:09:45 INF New device connection (device=HLWU6C2 address=192.168.1.4:22000 remote.name=machine4 remote.client=syncthing remote.version=v2.1.3 log.pkg=model)673machine3 # [27765.377483] machine3 syncthing[256]: 2026-09-04 15:09:45 INF Established secure connection (device=HLWU6C2 connection.local=192.168.1.3:22000 connection.remote=192.168.1.4:35142 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QTBA440L0LDSC6JRF194UI log.pkg=connections)674machine3 # [27765.377483] machine3 syncthing[256]: 2026-09-04 15:09:45 INF Additional device connection (device=HLWU6C2 address=192.168.1.4:35142 count=1 log.pkg=model)675machine1 # [27765.363352] machine1 syncthing[236]: 2026-09-04 15:09:45 INF Peer has a new index ID (device=PAVQZAT folder.id=documents folder.type=sendreceive indexid=0xA04672968762471C log.pkg=model)676machine1 # [27765.364096] machine1 syncthing[236]: 2026-09-04 15:09:45 INF Peer has a new index ID (device=PR4ZCBE folder.id=documents folder.type=sendreceive indexid=0x715EC05DCAC18E46 log.pkg=model)677machine1 # [27765.367920] machine1 syncthing[236]: 2026-09-04 15:09:45 INF Established secure connection (device=HLWU6C2 connection.local=192.168.1.1:22000 connection.remote=192.168.1.4:22000 connection.type=tcp-server connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QTB8TTE2C2G5ESUKG1LM5M log.pkg=connections)678machine1 # [27765.367920] machine1 syncthing[236]: 2026-09-04 15:09:45 INF New device connection (device=HLWU6C2 address=192.168.1.4:22000 remote.name=machine4 remote.client=syncthing remote.version=v2.1.3 log.pkg=model)679machine4 # [27765.357592] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Lost device connection (kind=primary device=J6AWUPP connection=192.168.1.4:22000-192.168.1.1:22000/tcp-client/TLS1.3-TLS_AES_128_GCM_SHA256/LAN-P10-66I4QT7C7BFPO4JGQ6EJQUVU6K error="reading length: EOF" remaining=0 log.pkg=model)680machine4 # [27765.357592] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Connection closed (device=J6AWUPP connection=192.168.1.4:22000-192.168.1.1:22000/tcp-client/TLS1.3-TLS_AES_128_GCM_SHA256/LAN-P10-66I4QT7C7BFPO4JGQ6EJQUVU6K error="reading length: EOF" log.pkg=model)681machine4 # [27765.358045] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Lost device connection (kind=primary device=PR4ZCBE connection=192.168.1.4:22000-192.168.1.2:22000/tcp-client/TLS1.3-TLS_AES_128_GCM_SHA256/LAN-P10-66I4QT7ELB506GDICK3IK5LDEC error="reading length: EOF" remaining=0 log.pkg=model)682machine4 # [27765.358045] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Connection closed (device=PR4ZCBE connection=192.168.1.4:22000-192.168.1.2:22000/tcp-client/TLS1.3-TLS_AES_128_GCM_SHA256/LAN-P10-66I4QT7ELB506GDICK3IK5LDEC error="reading length: EOF" log.pkg=model)683machine4 # [27765.358167] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Lost device connection (kind=primary device=PAVQZAT connection=192.168.1.4:22000-192.168.1.3:22000/tcp-client/TLS1.3-TLS_AES_128_GCM_SHA256/LAN-P10-66I4QT7G8T0SUM8NUHBFS0R028 error="reading length: EOF" remaining=0 log.pkg=model)684machine4 # [27765.358548] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Connection closed (device=PAVQZAT connection=192.168.1.4:22000-192.168.1.3:22000/tcp-client/TLS1.3-TLS_AES_128_GCM_SHA256/LAN-P10-66I4QT7G8T0SUM8NUHBFS0R028 error="reading length: EOF" log.pkg=model)685machine4 # [27765.367870] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Established secure connection (device=J6AWUPP connection.local=192.168.1.4:22000 connection.remote=192.168.1.1:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QTB8TTE2CRIFKK2F3QKS94 log.pkg=connections)686machine4 # [27765.367970] machine4 syncthing[236]: 2026-09-04 15:09:45 INF New device connection (device=J6AWUPP address=192.168.1.1:22000 remote.name=machine1 remote.client=syncthing remote.version=v2.1.3 log.pkg=model)687machine4 # [27765.368180] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Established secure connection (device=PR4ZCBE connection.local=192.168.1.4:22000 connection.remote=192.168.1.2:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QTB8VRG3OKAI67LI2273CS log.pkg=connections)688machine4 # [27765.368180] machine4 syncthing[236]: 2026-09-04 15:09:45 INF New device connection (device=PR4ZCBE address=192.168.1.2:22000 remote.name=machine2 remote.client=syncthing remote.version=v2.1.3 log.pkg=model)689machine4 # [27765.370157] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Established secure connection (device=PAVQZAT connection.local=192.168.1.4:22000 connection.remote=192.168.1.3:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QTB97TLPE2IRUFE7K9M4DK log.pkg=connections)690machine4 # [27765.370188] machine4 syncthing[236]: 2026-09-04 15:09:45 INF New device connection (device=PAVQZAT address=192.168.1.3:22000 remote.name=machine3 remote.client=syncthing remote.version=v2.1.3 log.pkg=model)691machine4 # [27765.377517] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Established secure connection (device=PAVQZAT connection.local=192.168.1.4:35142 connection.remote=192.168.1.3:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QTBA440L0BDDK47SVFTAVQ log.pkg=connections)692machine4 # [27765.377517] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Additional device connection (device=PAVQZAT address=192.168.1.3:22000 count=1 log.pkg=model)693machine4 # [27765.379989] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Established secure connection (device=PR4ZCBE connection.local=192.168.1.4:57950 connection.remote=192.168.1.2:22000 connection.type=tcp-client connection.lan=true connection.crypto=TLS1.3-TLS_AES_128_GCM_SHA256 connection.prio=10 connection.id=66I4QTBACS8BICGHFQ1CU2I0LQ log.pkg=connections)694machine4 # [27765.379989] machine4 syncthing[236]: 2026-09-04 15:09:45 INF Additional device connection (device=PR4ZCBE address=192.168.1.2:22000 count=1 log.pkg=model)695machine3 # [27766.383564] machine3 syncthing[256]: 2026-09-04 15:09:46 INF Peer has a new index ID (device=HLWU6C2 folder.id=documents folder.type=sendreceive indexid=0x38006036167838B2 log.pkg=model)696machine3 # [27766.384558] machine3 syncthing[256]: 2026-09-04 15:09:46 INF Peer has a new index ID (device=HLWU6C2 folder.id=pictures folder.type=sendreceive indexid=0x91D4DD32F37C125C log.pkg=model)697machine1 # [27766.383674] machine1 syncthing[236]: 2026-09-04 15:09:46 INF Peer has a new index ID (device=HLWU6C2 folder.id=documents folder.type=sendreceive indexid=0x38006036167838B2 log.pkg=model)698machine1 # [27766.384684] machine1 syncthing[236]: 2026-09-04 15:09:46 INF Peer has a new index ID (device=HLWU6C2 folder.id=partly_shared folder.type=sendreceive indexid=0xBC5B7D60D21E4915 log.pkg=model)699machine4 # [27766.382169] machine4 syncthing[236]: 2026-09-04 15:09:46 INF Peer has a new index ID (device=J6AWUPP folder.id=documents folder.type=sendreceive indexid=0x6CC42C8184F9E6D4 log.pkg=model)700machine4 # [27766.382920] machine4 syncthing[236]: 2026-09-04 15:09:46 INF Peer has a new index ID (device=PAVQZAT folder.id=documents folder.type=sendreceive indexid=0xA04672968762471C log.pkg=model)701machine4 # [27766.383383] machine4 syncthing[236]: 2026-09-04 15:09:46 INF Peer has a new index ID (device=PR4ZCBE folder.id=documents folder.type=sendreceive indexid=0x715EC05DCAC18E46 log.pkg=model)702machine4 # [27766.383383] machine4 syncthing[236]: 2026-09-04 15:09:46 INF Peer has a new index ID (device=J6AWUPP folder.id=partly_shared folder.type=sendreceive indexid=0x45733B4B57075E3D log.pkg=model)703machine4 # [27766.384713] machine4 syncthing[236]: 2026-09-04 15:09:46 INF Peer has a new index ID (device=PAVQZAT folder.id=pictures folder.type=sendreceive indexid=0x1E0649C72903E520 log.pkg=model)704machine2 # [27766.382634] machine2 syncthing[235]: 2026-09-04 15:09:46 INF Peer has a new index ID (device=HLWU6C2 folder.id=documents folder.type=sendreceive indexid=0x38006036167838B2 log.pkg=model)705machine3 # [27775.408933] machine3 syncthing[256]: 2026-09-04 15:09:55 INF Synced file (folder.id=documents folder.type=sendreceive file.name=document file.modified="2026-09-04 15:09:44.692975492 +0000 UTC" file.permissions=0644 file.size=9 file.blocksize=131072 blocks.local=0 blocks.download=1 log.pkg=model)706machine4 # [27775.409425] machine4 syncthing[236]: 2026-09-04 15:09:55 INF Synced file (folder.id=documents folder.type=sendreceive file.name=document file.modified="2026-09-04 15:09:44.692975492 +0000 UTC" file.permissions=0644 file.size=9 file.blocksize=131072 blocks.local=0 blocks.download=1 log.pkg=model)707machine4 # [27775.447276] machine4 syncthing[236]: 2026-09-04 15:09:55 INF Synced file (folder.id=pictures folder.type=sendreceive file.name=picture file.modified="2026-09-04 15:09:44.704389652 +0000 UTC" file.permissions=0644 file.size=8 file.blocksize=131072 blocks.local=0 blocks.download=1 log.pkg=model)708machine4 # [27775.462101] machine4 syncthing[236]: 2026-09-04 15:09:55 INF Synced file (folder.id=partly_shared folder.type=sendreceive file.name=music file.modified="2026-09-04 15:09:44.698441369 +0000 UTC" file.permissions=0644 file.size=6 file.blocksize=131072 blocks.local=0 blocks.download=1 log.pkg=model)709machine2: (finished: waiting for file '/var/lib/syncthing/documents/document', in 11.09 seconds)710machine3: waiting for file '/var/lib/syncthing/documents/document'711machine3: (finished: waiting for file '/var/lib/syncthing/documents/document', in 0.01 seconds)712machine4: waiting for file '/var/lib/syncthing/documents/document'713machine4: (finished: waiting for file '/var/lib/syncthing/documents/document', in 0.01 seconds)714machine4: waiting for file '/var/lib/syncthing/music/music'715machine4: (finished: waiting for file '/var/lib/syncthing/music/music', in 0.01 seconds)716machine2: must fail: test -e /var/lib/syncthing/music/music717machine2: (finished: must fail: test -e /var/lib/syncthing/music/music, in 0.01 seconds)718machine3: must fail: test -e /var/lib/syncthing/music/music719machine3: (finished: must fail: test -e /var/lib/syncthing/music/music, in 0.01 seconds)720machine4: waiting for file '/var/lib/syncthing/pictures/picture'721machine4: (finished: waiting for file '/var/lib/syncthing/pictures/picture', in 0.01 seconds)722machine1: must fail: test -e /var/lib/syncthing/pictures/picture723machine1: (finished: must fail: test -e /var/lib/syncthing/pictures/picture, in 0.01 seconds)724machine2: must fail: test -e /var/lib/syncthing/pictures/picture725machine2: (finished: must fail: test -e /var/lib/syncthing/pictures/picture, in 0.01 seconds)726(finished: run the VM test script, in 14.51 seconds)727machine2 # [27775.408718] machine2 syncthing[235]: 2026-09-04 15:09:55 INF Synced file (folder.id=documents folder.type=sendreceive file.name=document file.modified="2026-09-04 15:09:44.692975492 +0000 UTC" file.permissions=0644 file.size=9 file.blocksize=131072 blocks.local=0 blocks.download=1 log.pkg=model)728test script finished in 14.61s729cleanup730kill NspawnMachine (pid 54)731kill NspawnMachine (pid 55)732Container machine1 terminated by signal KILL.733kill NspawnMachine (pid 56)734Container machine2 terminated by signal KILL.735kill NspawnMachine (pid 57)736Container machine3 terminated by signal KILL.737Container machine4 terminated by signal KILL.738(finished: cleanup, in 0.61 seconds)