container-test-run-wireguard
default.checks.aarch64-linux.wireguard
· build #369
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.01 seconds)45Test will time out and terminate in 3600.0 seconds6run the VM test script7additionally exposed symbols:8 ctrl1, ctrl2, peer1, peer2, peer3,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 VMs12ctrl2: systemd-nspawn running (pid 54)13ctrl1: systemd-nspawn running (pid 55)14peer1: systemd-nspawn running (pid 57)15ctrl1: Waiting for journal at /build/vm-state-ctrl1/var/log/journal...16peer1: Waiting for journal at /build/vm-state-peer1/var/log/journal...17ctrl2: Waiting for journal at /build/vm-state-ctrl2/var/log/journal...18peer2: systemd-nspawn running (pid 63)19peer3: systemd-nspawn running (pid 65)20peer2: Waiting for journal at /build/vm-state-peer2/var/log/journal...21peer3: Waiting for journal at /build/vm-state-peer3/var/log/journal...22(finished: start all VMs, in 0.01 seconds)23nixos-nspawn(ctrl2): TAP vde-tap1 not found; container will be isolated from VDE24nixos-nspawn(ctrl2): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths.25nixos-nspawn(peer3): TAP vde-tap1 not found; container will be isolated from VDE26nixos-nspawn(peer3): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths.27nixos-nspawn(ctrl1): TAP vde-tap1 not found; container will be isolated from VDE28nixos-nspawn(ctrl1): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths.29nixos-nspawn(peer2): TAP vde-tap1 not found; container will be isolated from VDE30nixos-nspawn(peer2): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths.31nixos-nspawn(peer1): TAP vde-tap1 not found; container will be isolated from VDE32nixos-nspawn(peer1): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths.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.34Note: 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.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 peer3 on /build/vm-state-peer3.37░ Spawning container ctrl2 on /build/vm-state-ctrl2.38Note: 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.39░ Spawning container ctrl1 on /build/vm-state-ctrl1.40Note: 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.41░ Spawning container peer1 on /build/vm-state-peer1.42░ Spawning container peer2 on /build/vm-state-peer2.43peer1 # No journal files were found.44peer1 # No journal boot entry found for the specified boot (+0).45ctrl2 # No journal files were found.46ctrl2 # No journal boot entry found for the specified boot (+0).47ctrl1 # No journal files were found.48ctrl1 # No journal boot entry found for the specified boot (+0).49peer2 # No journal files were found.50peer2 # No journal boot entry found for the specified boot (+0).51peer3 # No journal files were found.52peer3 # No journal boot entry found for the specified boot (+0).53ctrl1 # [5897234.840642] ctrl1 systemd-journald[78]: Journal started54ctrl2 # [5897234.849206] ctrl2 systemd-journald[78]: Journal started55ctrl1 # [5897234.840693] ctrl1 systemd-journald[78]: Runtime Journal (/run/log/journal/36108667b3b2455683833522b9cad2d0) is 8M, max 2.5G, 2.4G free.56ctrl2 # [5897234.849270] ctrl2 systemd-journald[78]: Runtime Journal (/run/log/journal/e8997e3a5a164553a480c3db60ff6dc1) is 8M, max 2.5G, 2.4G free.57peer1 # [5897234.831822] peer1 systemd-journald[78]: Journal started58ctrl1 # [5897234.848711] ctrl1 systemd[1]: Starting Flush Journal to Persistent Storage...59peer1 # [5897234.831883] peer1 systemd-journald[78]: Runtime Journal (/run/log/journal/715a8516226a472da69054eccae99daa) is 8M, max 2.5G, 2.4G free.60ctrl2 # [5897234.863774] ctrl2 systemd[1]: Finished Create Static Device Nodes in /dev.61peer1 # [5897234.837686] peer1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.62ctrl2 # [5897234.864749] ctrl2 systemd[1]: Reached target Preparation for Local File Systems.63peer1 # [5897234.847543] peer1 systemd[1]: Starting Flush Journal to Persistent Storage...64ctrl2 # [5897234.864868] ctrl2 systemd[1]: Reached target Local File Systems.65peer1 # [5897234.848386] peer1 systemd[1]: Starting Network Name Resolution...66ctrl2 # [5897234.865690] ctrl2 systemd[1]: Listening on Boot Loader Control Service Socket.67peer1 # [5897234.850460] peer1 systemd[1]: Starting Create Static Device Nodes in /dev...68ctrl1 # [5897234.849565] ctrl1 systemd[1]: Starting Network Name Resolution...69peer1 # [5897234.858652] peer1 systemd-journald[78]: Time spent on flushing to /var/log/journal/715a8516226a472da69054eccae99daa is 6.297ms for 6 entries.70ctrl1 # [5897234.851061] ctrl1 systemd[1]: Starting Create Static Device Nodes in /dev...71peer1 # [5897234.858652] peer1 systemd-journald[78]: System Journal (/var/log/journal/715a8516226a472da69054eccae99daa) is 8M, max 4G, 3.9G free.72ctrl1 # [5897234.858701] ctrl1 systemd-journald[78]: Time spent on flushing to /var/log/journal/36108667b3b2455683833522b9cad2d0 is 3.285ms for 5 entries.73peer1 # [5897234.878722] peer1 systemd[1]: Finished Create Static Device Nodes in /dev.74ctrl1 # [5897234.858701] ctrl1 systemd-journald[78]: System Journal (/var/log/journal/36108667b3b2455683833522b9cad2d0) is 8M, max 4G, 3.9G free.75peer1 # [5897234.879780] peer1 systemd[1]: Reached target Preparation for Local File Systems.76ctrl1 # [5897234.871303] ctrl1 systemd[1]: Finished Create Static Device Nodes in /dev.77peer1 # [5897234.879915] peer1 systemd[1]: Reached target Local File Systems.78ctrl2 # [5897234.865735] ctrl2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container79peer1 # [5897234.880756] peer1 systemd[1]: Listening on Boot Loader Control Service Socket.80ctrl2 # [5897234.866675] ctrl2 systemd[1]: Starting Flush Journal to Persistent Storage...81peer1 # [5897234.880801] peer1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container82ctrl2 # [5897234.867650] ctrl2 systemd[1]: Starting Save Transient machine-id to Disk...83peer1 # [5897234.881673] peer1 systemd[1]: Starting Save Transient machine-id to Disk...84ctrl2 # [5897234.867687] ctrl2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys85ctrl1 # [5897234.871532] ctrl1 systemd[1]: Reached target Preparation for Local File Systems.86peer1 # [5897234.881709] peer1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys87ctrl2 # [5897234.879072] ctrl2 systemd-journald[78]: Time spent on flushing to /var/log/journal/e8997e3a5a164553a480c3db60ff6dc1 is 3.154ms for 10 entries.88peer1 # [5897234.896978] peer1 systemd[1]: Finished Flush Journal to Persistent Storage.89ctrl2 # [5897234.879072] ctrl2 systemd-journald[78]: System Journal (/var/log/journal/e8997e3a5a164553a480c3db60ff6dc1) is 8M, max 4G, 3.9G free.90peer1 # [5897234.898495] peer1 systemd[1]: Starting Create System Files and Directories...91ctrl2 # [5897234.925247] ctrl2 systemd[1]: Finished Flush Journal to Persistent Storage.92peer1 # [5897234.914633] peer1 systemd-tmpfiles[130]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted93ctrl2 # [5897234.927287] ctrl2 systemd[1]: Starting Create System Files and Directories...94peer1 # [5897234.914865] peer1 systemd-tmpfiles[130]: fchmod() of /var/log/journal failed: Operation not permitted95ctrl2 # [5897234.949841] ctrl2 systemd-tmpfiles[146]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted96peer1 # [5897234.915027] peer1 systemd-tmpfiles[130]: fchmod() of /var/log/journal/715a8516226a472da69054eccae99daa failed: Operation not permitted97ctrl2 # [5897234.950246] ctrl2 systemd-tmpfiles[146]: fchmod() of /var/log/journal failed: Operation not permitted98peer2 # [5897234.833220] peer2 systemd-journald[78]: Journal started99ctrl2 # [5897234.950414] ctrl2 systemd-tmpfiles[146]: fchmod() of /var/log/journal/e8997e3a5a164553a480c3db60ff6dc1 failed: Operation not permitted100peer1 # [5897234.915276] peer1 systemd-tmpfiles[130]: fchmod() of /run/log/journal failed: Operation not permitted101peer2 # [5897234.833277] peer2 systemd-journald[78]: Runtime Journal (/run/log/journal/0dd9c2f516aa43c68b84dbf702a45a7a) is 8M, max 2.5G, 2.4G free.102ctrl2 # [5897234.950676] ctrl2 systemd-tmpfiles[146]: fchmod() of /run/log/journal failed: Operation not permitted103ctrl1 # [5897234.871627] ctrl1 systemd[1]: Reached target Local File Systems.104peer2 # [5897234.836616] peer2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.105ctrl2 # [5897234.953405] ctrl2 systemd[1]: Finished Create System Files and Directories.106peer1 # [5897234.917370] peer1 systemd[1]: Finished Create System Files and Directories.107peer2 # [5897234.847540] peer2 systemd[1]: Starting Flush Journal to Persistent Storage...108ctrl2 # [5897234.954742] ctrl2 systemd[1]: Starting Rebuild Journal Catalog...109peer1 # [5897234.918456] peer1 systemd[1]: Starting Rebuild Journal Catalog...110peer2 # [5897234.850990] peer2 systemd[1]: Starting Network Name Resolution...111ctrl2 # [5897234.955769] ctrl2 systemd[1]: Starting Record System Boot/Shutdown in UTMP...112peer1 # [5897234.919202] peer1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...113ctrl1 # [5897234.872488] ctrl1 systemd[1]: Listening on Boot Loader Control Service Socket.114peer2 # [5897234.852645] peer2 systemd[1]: Starting Create Static Device Nodes in /dev...115ctrl2 # [5897234.969630] ctrl2 systemd[1]: Finished Record System Boot/Shutdown in UTMP.116peer1 # [5897234.933165] peer1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.117peer2 # [5897234.859430] peer2 systemd-journald[78]: Time spent on flushing to /var/log/journal/0dd9c2f516aa43c68b84dbf702a45a7a is 4.283ms for 6 entries.118ctrl1 # [5897234.872553] ctrl1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container119ctrl2 # [5897234.981823] ctrl2 systemd[1]: Finished Rebuild Journal Catalog.120peer1 # [5897234.948822] peer1 systemd[1]: Finished Rebuild Journal Catalog.121peer2 # [5897234.859430] peer2 systemd-journald[78]: System Journal (/var/log/journal/0dd9c2f516aa43c68b84dbf702a45a7a) is 8M, max 4G, 3.9G free.122peer1 # [5897234.950432] peer1 systemd[1]: Starting Update is Completed...123ctrl2 # [5897234.983181] ctrl2 systemd[1]: Starting Update is Completed...124ctrl2 # [5897234.996373] ctrl2 systemd[1]: Finished Update is Completed.125peer1 # [5897234.962884] peer1 systemd[1]: Finished Update is Completed.126ctrl1 # [5897234.873561] ctrl1 systemd[1]: Starting Save Transient machine-id to Disk...127ctrl2 # [5897235.032612] ctrl2 systemd[1]: Finished Firewall.128peer2 # [5897234.878909] peer2 systemd[1]: Finished Create Static Device Nodes in /dev.129ctrl1 # [5897234.873594] ctrl1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys130peer1 # [5897235.025422] peer1 systemd[1]: Finished Firewall.131peer2 # [5897234.879197] peer2 systemd[1]: Reached target Preparation for Local File Systems.132ctrl2 # [5897235.032779] ctrl2 systemd[1]: Reached target Preparation for Network.133ctrl1 # [5897234.897227] ctrl1 systemd[1]: Finished Flush Journal to Persistent Storage.134peer1 # [5897235.026043] peer1 systemd[1]: Reached target Preparation for Network.135peer2 # [5897234.879285] peer2 systemd[1]: Reached target Local File Systems.136ctrl1 # [5897234.899167] ctrl1 systemd[1]: Starting Create System Files and Directories...137ctrl2 # [5897235.033046] ctrl2 systemd[1]: Listening on Network Management Resolve Hook Socket.138peer1 # [5897235.026378] peer1 systemd[1]: Listening on Network Management Resolve Hook Socket.139peer2 # [5897234.880069] peer2 systemd[1]: Listening on Boot Loader Control Service Socket.140peer2 # [5897234.880124] peer2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container141ctrl2 # [5897235.034116] ctrl2 systemd[1]: Starting Network Management...142ctrl1 # [5897234.915081] ctrl1 systemd-tmpfiles[129]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted143peer2 # [5897234.881029] peer2 systemd[1]: Starting Save Transient machine-id to Disk...144ctrl2 # [5897235.542262] ctrl2 systemd-networkd[193]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted145ctrl1 # [5897234.915317] ctrl1 systemd-tmpfiles[129]: fchmod() of /var/log/journal failed: Operation not permitted146ctrl1 # [5897234.915482] ctrl1 systemd-tmpfiles[129]: fchmod() of /var/log/journal/36108667b3b2455683833522b9cad2d0 failed: Operation not permitted147ctrl1 # [5897234.915724] ctrl1 systemd-tmpfiles[129]: fchmod() of /run/log/journal failed: Operation not permitted148ctrl2 # [5897235.542361] ctrl2 systemd-networkd[193]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted149ctrl1 # [5897234.920119] ctrl1 systemd[1]: Finished Create System Files and Directories.150ctrl1 # [5897234.922557] ctrl1 systemd[1]: Starting Rebuild Journal Catalog...151ctrl2 # [5897235.549049] ctrl2 systemd-networkd[193]: /etc/systemd/network/40-wg-test-one.netdev:17: Specified address 'fd51:19c1:e:fb00:6987:50a0:9b93:4337/96' is not properly masked, assuming 'fd51:19c1:e:fb00:6987:50a0::/96'.152peer1 # [5897235.028146] peer1 systemd[1]: Starting Network Management...153peer2 # [5897234.881069] peer2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys154ctrl1 # [5897234.923385] ctrl1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...155ctrl1 # [5897234.942399] ctrl1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.156ctrl2 # [5897235.549067] ctrl2 systemd-networkd[193]: /etc/systemd/network/40-wg-test-one.netdev:18: Specified address 'fd51:19c1:89:500:6987:50a0:9b93:4337/96' is not properly masked, assuming 'fd51:19c1:89:500:6987:50a0::/96'.157peer2 # [5897234.881579] peer2 systemd[1]: Finished Flush Journal to Persistent Storage.158ctrl1 # [5897234.948743] ctrl1 systemd[1]: Finished Rebuild Journal Catalog.159ctrl2 # [5897235.549082] ctrl2 systemd-networkd[193]: /etc/systemd/network/40-wg-test-one.netdev:23: Specified address 'fd51:19c1:e:fb00:3b21:3ced:003e:89b3/96' is not properly masked, assuming 'fd51:19c1:e:fb00:3b21:3ced::/96'.160peer1 # [5897235.513386] peer1 systemd-networkd[191]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted161peer2 # [5897234.883248] peer2 systemd[1]: Starting Create System Files and Directories...162peer2 # [5897234.900331] peer2 systemd-tmpfiles[121]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted163peer1 # [5897235.513530] peer1 systemd-networkd[191]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted164ctrl1 # [5897234.949914] ctrl1 systemd[1]: Starting Update is Completed...165ctrl2 # [5897235.549090] ctrl2 systemd-networkd[193]: /etc/systemd/network/40-wg-test-one.netdev:24: Specified address 'fd51:19c1:89:500:3b21:3ced:003e:89b3/96' is not properly masked, assuming 'fd51:19c1:89:500:3b21:3ced::/96'.166ctrl1 # [5897234.963784] ctrl1 systemd[1]: Finished Update is Completed.167peer1 # [5897235.522846] peer1 systemd-networkd[191]: /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.168ctrl1 # [5897235.029772] ctrl1 systemd[1]: Finished Firewall.169ctrl2 # [5897235.549103] ctrl2 systemd-networkd[193]: /etc/systemd/network/40-wg-test-one.netdev:29: Specified address 'fd51:19c1:e:fb00:e42b:bf85:33f4:f0b1/96' is not properly masked, assuming 'fd51:19c1:e:fb00:e42b:bf85::/96'.170peer2 # [5897234.900911] peer2 systemd-tmpfiles[121]: fchmod() of /var/log/journal failed: Operation not permitted171peer1 # [5897235.523058] peer1 systemd-networkd[191]: /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.172ctrl1 # [5897235.030499] ctrl1 systemd[1]: Reached target Preparation for Network.173ctrl2 # [5897235.549108] ctrl2 systemd-networkd[193]: /etc/systemd/network/40-wg-test-one.netdev:30: Specified address 'fd51:19c1:89:500:e42b:bf85:33f4:f0b1/96' is not properly masked, assuming 'fd51:19c1:89:500:e42b:bf85::/96'.174peer2 # [5897234.901078] peer2 systemd-tmpfiles[121]: fchmod() of /var/log/journal/0dd9c2f516aa43c68b84dbf702a45a7a failed: Operation not permitted175peer1 # [5897235.523243] peer1 systemd-networkd[191]: lo: Link UP176ctrl2 # [5897235.551636] ctrl2 systemd-networkd[193]: /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.177peer1 # [5897235.523247] peer1 systemd-networkd[191]: lo: Gained carrier178peer2 # [5897234.901336] peer2 systemd-tmpfiles[121]: fchmod() of /run/log/journal failed: Operation not permitted179ctrl1 # [5897235.030882] ctrl1 systemd[1]: Listening on Network Management Resolve Hook Socket.180ctrl2 # [5897235.551793] ctrl2 systemd-networkd[193]: /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.181peer1 # [5897235.523465] peer1 systemd-networkd[191]: eth1: Configuring with /etc/systemd/network/40-eth1.network.182peer2 # [5897234.907603] peer2 systemd[1]: Finished Create System Files and Directories.183ctrl1 # [5897235.032084] ctrl1 systemd[1]: Starting Network Management...184ctrl2 # [5897235.552426] ctrl2 systemd-networkd[193]: lo: Link UP185peer2 # [5897234.908800] peer2 systemd[1]: Starting Rebuild Journal Catalog...186ctrl1 # [5897235.543870] ctrl1 systemd-networkd[193]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted187ctrl2 # [5897235.552433] ctrl2 systemd-networkd[193]: lo: Gained carrier188peer1 # [5897235.523910] peer1 systemd[1]: Started Network Management.189peer2 # [5897234.909576] peer2 systemd[1]: Starting Record System Boot/Shutdown in UTMP...190ctrl1 # [5897235.543963] ctrl1 systemd-networkd[193]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted191ctrl2 # [5897235.552641] ctrl2 systemd-networkd[193]: eth1: Configuring with /etc/systemd/network/40-eth1.network.192peer1 # [5897235.525167] peer1 systemd-networkd[191]: wg-test-one: Configuring with /etc/systemd/network/40-wg-test-one.network.193peer2 # [5897234.924024] peer2 systemd[1]: Finished Record System Boot/Shutdown in UTMP.194ctrl1 # [5897235.550271] ctrl1 systemd-networkd[193]: /etc/systemd/network/40-wg-test-one.netdev:17: Specified address 'fd51:19c1:e:fb00:6987:50a0:9b93:4337/96' is not properly masked, assuming 'fd51:19c1:e:fb00:6987:50a0::/96'.195ctrl2 # [5897235.553191] ctrl2 systemd[1]: Started Network Management.196peer1 # [5897235.526029] peer1 systemd-networkd[191]: wg-test-one: netdev ready197peer2 # [5897234.934487] peer2 systemd[1]: Finished Rebuild Journal Catalog.198peer1 # [5897235.526142] peer1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...199peer2 # [5897234.935722] peer2 systemd[1]: Starting Update is Completed...200peer1 # [5897235.527786] peer1 systemd-networkd[191]: eth1: Link UP201peer2 # [5897234.946893] peer2 systemd[1]: Finished Update is Completed.202peer1 # [5897235.528441] peer1 systemd-networkd[191]: eth1: Gained carrier203peer2 # [5897235.018524] peer2 systemd[1]: Finished Firewall.204ctrl1 # [5897235.550288] ctrl1 systemd-networkd[193]: /etc/systemd/network/40-wg-test-one.netdev:18: Specified address 'fd51:19c1:89:500:6987:50a0:9b93:4337/96' is not properly masked, assuming 'fd51:19c1:89:500:6987:50a0::/96'.205peer2 # [5897235.018937] peer2 systemd[1]: Reached target Preparation for Network.206ctrl1 # [5897235.550301] ctrl1 systemd-networkd[193]: /etc/systemd/network/40-wg-test-one.netdev:23: Specified address 'fd51:19c1:e:fb00:3b21:3ced:003e:89b3/96' is not properly masked, assuming 'fd51:19c1:e:fb00:3b21:3ced::/96'.207peer2 # [5897235.019171] peer2 systemd[1]: Listening on Network Management Resolve Hook Socket.208ctrl1 # [5897235.550308] ctrl1 systemd-networkd[193]: /etc/systemd/network/40-wg-test-one.netdev:24: Specified address 'fd51:19c1:89:500:3b21:3ced:003e:89b3/96' is not properly masked, assuming 'fd51:19c1:89:500:3b21:3ced::/96'.209peer2 # [5897235.020379] peer2 systemd[1]: Starting Network Management...210ctrl1 # [5897235.550321] ctrl1 systemd-networkd[193]: /etc/systemd/network/40-wg-test-one.netdev:29: Specified address 'fd51:19c1:e:fb00:e42b:bf85:33f4:f0b1/96' is not properly masked, assuming 'fd51:19c1:e:fb00:e42b:bf85::/96'.211peer2 # [5897235.543860] peer2 systemd-networkd[191]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted212ctrl1 # [5897235.550328] ctrl1 systemd-networkd[193]: /etc/systemd/network/40-wg-test-one.netdev:30: Specified address 'fd51:19c1:89:500:e42b:bf85:33f4:f0b1/96' is not properly masked, assuming 'fd51:19c1:89:500:e42b:bf85::/96'.213peer2 # [5897235.543952] peer2 systemd-networkd[191]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted214ctrl1 # [5897235.552839] ctrl1 systemd-networkd[193]: /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.215peer2 # [5897235.552529] peer2 systemd-networkd[191]: /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.216ctrl1 # [5897235.553002] ctrl1 systemd-networkd[193]: /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.217peer2 # [5897235.552693] peer2 systemd-networkd[191]: /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.218ctrl1 # [5897235.553150] ctrl1 systemd-networkd[193]: lo: Link UP219peer2 # [5897235.552850] peer2 systemd-networkd[191]: lo: Link UP220ctrl1 # [5897235.553153] ctrl1 systemd-networkd[193]: lo: Gained carrier221peer2 # [5897235.552854] peer2 systemd-networkd[191]: lo: Gained carrier222ctrl1 # [5897235.553323] ctrl1 systemd-networkd[193]: eth1: Configuring with /etc/systemd/network/40-eth1.network.223peer2 # [5897235.553042] peer2 systemd-networkd[191]: eth1: Configuring with /etc/systemd/network/40-eth1.network.224ctrl1 # [5897235.553768] ctrl1 systemd[1]: Started Network Management.225peer2 # [5897235.553588] peer2 systemd[1]: Started Network Management.226peer2 # [5897235.648426] peer2 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...227peer3 # [5897234.840568] peer3 systemd-journald[77]: Journal started228peer3 # [5897234.840622] peer3 systemd-journald[77]: Runtime Journal (/run/log/journal/0f325b98307d40d996992d9cd3894231) is 8M, max 2.5G, 2.4G free.229peer3 # [5897234.850927] peer3 systemd[1]: Starting Flush Journal to Persistent Storage...230peer3 # [5897234.854471] peer3 systemd[1]: Starting Network Name Resolution...231peer3 # [5897234.855733] peer3 systemd[1]: Starting Create Static Device Nodes in /dev...232peer3 # [5897234.862685] peer3 systemd-journald[77]: Time spent on flushing to /var/log/journal/0f325b98307d40d996992d9cd3894231 is 5.695ms for 5 entries.233peer3 # [5897234.862685] peer3 systemd-journald[77]: System Journal (/var/log/journal/0f325b98307d40d996992d9cd3894231) is 8M, max 4G, 3.9G free.234peer3 # [5897234.879827] peer3 systemd[1]: Finished Create Static Device Nodes in /dev.235peer3 # [5897234.880120] peer3 systemd[1]: Reached target Preparation for Local File Systems.236peer3 # [5897234.880209] peer3 systemd[1]: Reached target Local File Systems.237peer3 # [5897234.880935] peer3 systemd[1]: Listening on Boot Loader Control Service Socket.238peer3 # [5897234.880982] peer3 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container239peer3 # [5897234.881828] peer3 systemd[1]: Starting Save Transient machine-id to Disk...240peer3 # [5897234.881864] peer3 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys241peer3 # [5897234.895994] peer3 systemd[1]: Finished Flush Journal to Persistent Storage.242peer3 # [5897234.897662] peer3 systemd[1]: Starting Create System Files and Directories...243peer3 # [5897234.914582] peer3 systemd-tmpfiles[126]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted244peer3 # [5897234.914814] peer3 systemd-tmpfiles[126]: fchmod() of /var/log/journal failed: Operation not permitted245peer3 # [5897234.914978] peer3 systemd-tmpfiles[126]: fchmod() of /var/log/journal/0f325b98307d40d996992d9cd3894231 failed: Operation not permitted246peer3 # [5897234.915226] peer3 systemd-tmpfiles[126]: fchmod() of /run/log/journal failed: Operation not permitted247peer3 # [5897234.920182] peer3 systemd[1]: Finished Create System Files and Directories.248peer3 # [5897234.921751] peer3 systemd[1]: Starting Rebuild Journal Catalog...249peer3 # [5897234.922772] peer3 systemd[1]: Starting Record System Boot/Shutdown in UTMP...250peer3 # [5897234.937711] peer3 systemd[1]: Finished Record System Boot/Shutdown in UTMP.251peer3 # [5897234.949917] peer3 systemd[1]: Finished Rebuild Journal Catalog.252peer3 # [5897234.953436] peer3 systemd[1]: Starting Update is Completed...253peer3 # [5897234.965383] peer3 systemd[1]: Finished Update is Completed.254peer3 # [5897235.032703] peer3 systemd[1]: Finished Firewall.255peer3 # [5897235.033348] peer3 systemd[1]: Reached target Preparation for Network.256peer3 # [5897235.033626] peer3 systemd[1]: Listening on Network Management Resolve Hook Socket.257peer3 # [5897235.034722] peer3 systemd[1]: Starting Network Management...258peer3 # [5897235.536318] peer3 systemd-networkd[190]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted259peer3 # [5897235.536420] peer3 systemd-networkd[190]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted260peer3 # [5897235.545740] peer3 systemd-networkd[190]: /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.261peer3 # [5897235.545903] peer3 systemd-networkd[190]: /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.262peer3 # [5897235.546079] peer3 systemd-networkd[190]: lo: Link UP263peer3 # [5897235.546084] peer3 systemd-networkd[190]: lo: Gained carrier264peer3 # [5897235.546295] peer3 systemd-networkd[190]: eth1: Configuring with /etc/systemd/network/40-eth1.network.265peer3 # [5897235.546733] peer3 systemd[1]: Started Network Management.266peer3 # [5897235.645565] peer3 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...267peer3 # [5897235.654984] peer3 systemd-networkd[190]: wg-test-one: Configuring with /etc/systemd/network/40-wg-test-one.network.268peer3 # [5897235.655392] peer3 systemd-networkd[190]: wg-test-one: netdev ready269peer1 # [5897235.655007] peer1 systemd-networkd[191]: wg-test-one: Link UP270peer1 # [5897235.655017] peer1 systemd-networkd[191]: wg-test-one: Gained carrier271peer1 # [5897235.689673] peer1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.272peer3 # [5897235.668303] peer3 systemd-networkd[190]: eth1: Link UP273peer3 # [5897235.688345] peer3 systemd-networkd[190]: eth1: Gained carrier274peer3 # [5897235.762451] peer3 systemd-resolved[100]: Positive Trust Anchors:275peer3 # [5897235.762463] peer3 systemd-resolved[100]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d276peer3 # [5897235.762467] peer3 systemd-resolved[100]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16277peer3 # [5897235.762502] peer3 systemd-resolved[100]: 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 test278peer3 # [5897235.763241] peer3 systemd-networkd[190]: wg-test-one: Link UP279peer3 # [5897235.763244] peer3 systemd-networkd[190]: wg-test-one: Gained carrier280peer3 # [5897235.764604] peer3 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.281peer3 # [5897235.785703] peer3 systemd-resolved[100]: Using system hostname 'peer3'.282peer3 # [5897235.787618] peer3 systemd[1]: Started Network Name Resolution.283peer3 # [5897235.787697] peer3 systemd[1]: Reached target Network.284peer3 # [5897235.787763] peer3 systemd[1]: Reached target System Initialization.285peer3 # [5897235.787821] peer3 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container286peer3 # [5897235.787848] peer3 systemd[1]: Started Daily Cleanup of Temporary Directories.287peer3 # [5897235.787868] peer3 systemd[1]: Reached target Timer Units.288peer3 # [5897235.787991] peer3 systemd[1]: Listening on D-Bus System Message Bus Socket.289peer3 # [5897235.788144] peer3 systemd[1]: Listening on Nix Daemon Socket.290peer3 # [5897235.788263] peer3 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.291peer3 # [5897235.788284] peer3 systemd[1]: Reached target Socket Units.292peer3 # [5897235.788320] peer3 systemd[1]: Reached target Basic System.293peer2 # [5897235.688741] peer2 systemd-networkd[191]: wg-test-one: Configuring with /etc/systemd/network/40-wg-test-one.network.294peer2 # [5897235.689097] peer2 systemd-networkd[191]: wg-test-one: netdev ready295peer2 # [5897235.693512] peer2 systemd-networkd[191]: eth1: Link UP296peer2 # [5897235.693749] peer2 systemd-networkd[191]: eth1: Gained carrier297peer2 # [5897235.751121] peer2 systemd-networkd[191]: wg-test-one: Link UP298peer2 # [5897235.751126] peer2 systemd-networkd[191]: wg-test-one: Gained carrier299peer2 # [5897235.754012] peer2 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.300peer2 # [5897235.775244] peer2 systemd-resolved[101]: Positive Trust Anchors:301peer2 # [5897235.775255] peer2 systemd-resolved[101]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d302peer2 # [5897235.775260] peer2 systemd-resolved[101]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16303peer2 # [5897235.775294] peer2 systemd-resolved[101]: 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 test304peer2 # [5897235.799496] peer2 systemd-resolved[101]: Using system hostname 'peer2'.305ctrl1 # [5897235.652118] ctrl1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...306ctrl2 # [5897235.651402] ctrl2 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...307ctrl1 # [5897235.687847] ctrl1 systemd-networkd[193]: wg-test-one: Configuring with /etc/systemd/network/40-wg-test-one.network.308ctrl2 # [5897235.688016] ctrl2 systemd-networkd[193]: wg-test-one: Configuring with /etc/systemd/network/40-wg-test-one.network.309ctrl1 # [5897235.688945] ctrl1 systemd-networkd[193]: wg-test-one: netdev ready310ctrl2 # [5897235.688947] ctrl2 systemd-networkd[193]: wg-test-one: netdev ready311ctrl1 # [5897235.691459] ctrl1 systemd-networkd[193]: eth1: Link UP312ctrl2 # [5897235.692630] ctrl2 systemd-networkd[193]: eth1: Link UP313ctrl1 # [5897235.692748] ctrl1 systemd-networkd[193]: eth1: Gained carrier314ctrl2 # [5897235.693584] ctrl2 systemd-networkd[193]: eth1: Gained carrier315ctrl1 # [5897235.694162] ctrl1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.316ctrl1 # [5897235.762886] ctrl1 systemd-resolved[104]: Positive Trust Anchors:317ctrl1 # [5897235.762898] ctrl1 systemd-resolved[104]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d318ctrl1 # [5897235.762902] ctrl1 systemd-resolved[104]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16319ctrl1 # [5897235.762936] ctrl1 systemd-resolved[104]: 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 test320ctrl1 # [5897235.763034] ctrl1 systemd-networkd[193]: wg-test-one: Link UP321ctrl1 # [5897235.763039] ctrl1 systemd-networkd[193]: wg-test-one: Gained carrier322ctrl1 # [5897235.785699] ctrl1 systemd-resolved[104]: Using system hostname 'ctrl1'.323ctrl1 # [5897235.787575] ctrl1 systemd[1]: Started Network Name Resolution.324ctrl1 # [5897235.787660] ctrl1 systemd[1]: Reached target Network.325ctrl1 # [5897235.787728] ctrl1 systemd[1]: Reached target System Initialization.326ctrl1 # [5897235.787780] ctrl1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container327ctrl1 # [5897235.787808] ctrl1 systemd[1]: Started Daily Cleanup of Temporary Directories.328ctrl1 # [5897235.787825] ctrl1 systemd[1]: Reached target Timer Units.329ctrl1 # [5897235.787957] ctrl1 systemd[1]: Listening on D-Bus System Message Bus Socket.330ctrl1 # [5897235.788105] ctrl1 systemd[1]: Listening on Nix Daemon Socket.331ctrl1 # [5897235.788222] ctrl1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.332ctrl1 # [5897235.788243] ctrl1 systemd[1]: Reached target Socket Units.333ctrl1 # [5897235.788283] ctrl1 systemd[1]: Reached target Basic System.334ctrl1 # [5897235.789985] ctrl1 systemd[1]: Starting Import lastlog data into lastlog2 database...335ctrl1 # [5897235.791016] ctrl1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...336ctrl2 # [5897235.751884] ctrl2 systemd-networkd[193]: wg-test-one: Link UP337ctrl2 # [5897235.751891] ctrl2 systemd-networkd[193]: wg-test-one: Gained carrier338ctrl2 # [5897235.753534] ctrl2 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.339ctrl2 # [5897235.762608] ctrl2 systemd-resolved[99]: Positive Trust Anchors:340ctrl2 # [5897235.762618] ctrl2 systemd-resolved[99]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d341ctrl2 # [5897235.762621] ctrl2 systemd-resolved[99]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16342ctrl2 # [5897235.762656] ctrl2 systemd-resolved[99]: 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 test343ctrl2 # [5897235.785699] ctrl2 systemd-resolved[99]: Using system hostname 'ctrl2'.344ctrl2 # [5897235.787606] ctrl2 systemd[1]: Started Network Name Resolution.345ctrl2 # [5897235.787688] ctrl2 systemd[1]: Reached target Network.346ctrl2 # [5897235.787763] ctrl2 systemd[1]: Reached target System Initialization.347ctrl2 # [5897235.787821] ctrl2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container348ctrl2 # [5897235.787852] ctrl2 systemd[1]: Started Daily Cleanup of Temporary Directories.349ctrl2 # [5897235.787869] ctrl2 systemd[1]: Reached target Timer Units.350ctrl2 # [5897235.787997] ctrl2 systemd[1]: Listening on D-Bus System Message Bus Socket.351ctrl2 # [5897235.788143] ctrl2 systemd[1]: Listening on Nix Daemon Socket.352ctrl2 # [5897235.788252] ctrl2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.353ctrl2 # [5897235.788272] ctrl2 systemd[1]: Reached target Socket Units.354ctrl2 # [5897235.788309] ctrl2 systemd[1]: Reached target Basic System.355ctrl2 # [5897235.789525] ctrl2 systemd[1]: Starting Import lastlog data into lastlog2 database...356ctrl2 # [5897235.790670] ctrl2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...357peer3 # [5897235.791166] peer3 systemd[1]: Starting Import lastlog data into lastlog2 database...358peer3 # [5897235.992744] peer3 systemd[1]: Starting Name Service Cache Daemon (nsncd)...359peer3 # [5897236.036877] peer3 systemd[1]: Starting D-Bus System Message Bus...360peer1 # [5897235.763990] peer1 systemd-resolved[103]: Positive Trust Anchors:361peer1 # [5897235.764012] peer1 systemd-resolved[103]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d362peer1 # [5897235.764016] peer1 systemd-resolved[103]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16363peer1 # [5897235.764050] peer1 systemd-resolved[103]: 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 test364peer1 # [5897235.786827] peer1 systemd-resolved[103]: Using system hostname 'peer1'.365peer1 # [5897235.789435] peer1 systemd[1]: Started Network Name Resolution.366peer1 # [5897235.789537] peer1 systemd[1]: Reached target Network.367peer1 # [5897235.789603] peer1 systemd[1]: Reached target System Initialization.368peer1 # [5897235.789655] peer1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container369peer1 # [5897235.789683] peer1 systemd[1]: Started Daily Cleanup of Temporary Directories.370peer1 # [5897235.789698] peer1 systemd[1]: Reached target Timer Units.371peer1 # [5897235.789824] peer1 systemd[1]: Listening on D-Bus System Message Bus Socket.372peer1 # [5897235.789947] peer1 systemd[1]: Listening on Nix Daemon Socket.373peer1 # [5897235.790060] peer1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.374peer1 # [5897235.790083] peer1 systemd[1]: Reached target Socket Units.375peer1 # [5897235.790123] peer1 systemd[1]: Reached target Basic System.376peer1 # [5897235.792031] peer1 systemd[1]: Starting Import lastlog data into lastlog2 database...377peer1 # [5897235.793333] peer1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...378peer1 # [5897235.992793] peer1 systemd[1]: Starting D-Bus System Message Bus...379peer2 # [5897235.801144] peer2 systemd[1]: Started Network Name Resolution.380peer2 # [5897235.801232] peer2 systemd[1]: Reached target Network.381peer2 # [5897235.801303] peer2 systemd[1]: Reached target System Initialization.382peer2 # [5897235.801354] peer2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container383peer2 # [5897235.801382] peer2 systemd[1]: Started Daily Cleanup of Temporary Directories.384peer2 # [5897235.801399] peer2 systemd[1]: Reached target Timer Units.385peer2 # [5897235.801531] peer2 systemd[1]: Listening on D-Bus System Message Bus Socket.386peer2 # [5897235.801653] peer2 systemd[1]: Listening on Nix Daemon Socket.387peer2 # [5897235.801753] peer2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.388peer2 # [5897235.801772] peer2 systemd[1]: Reached target Socket Units.389peer2 # [5897235.801806] peer2 systemd[1]: Reached target Basic System.390peer2 # [5897235.993923] peer2 systemd[1]: Starting Import lastlog data into lastlog2 database...391peer2 # [5897235.995726] peer2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...392peer2 # [5897236.039785] peer2 systemd[1]: Starting D-Bus System Message Bus...393peer2 # [5897236.049816] peer2 systemd[1]: Finished Import lastlog data into lastlog2 database.394ctrl2 # [5897235.992561] ctrl2 systemd[1]: Starting D-Bus System Message Bus...395ctrl1 # [5897235.992510] ctrl1 systemd[1]: Starting D-Bus System Message Bus...396ctrl2 # [5897236.046401] ctrl2 systemd[1]: Finished Import lastlog data into lastlog2 database.397ctrl2 # [5897236.182964] ctrl2 systemd[1]: Started Name Service Cache Daemon (nsncd).398ctrl2 # [5897236.183114] ctrl2 systemd[1]: Reached target Host and Network Name Lookups.399ctrl2 # [5897236.183253] ctrl2 systemd[1]: Reached target User and Group Name Lookups.400ctrl2 # [5897236.185184] ctrl2 nsncd[199]: Aug 16 05:31:02.238 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"401ctrl2 # [5897236.244510] ctrl2 systemd[1]: Starting User Login Management...402ctrl1 # [5897236.045587] ctrl1 systemd[1]: Finished Import lastlog data into lastlog2 database.403ctrl1 # [5897236.180325] ctrl1 nsncd[199]: Aug 16 05:31:02.233 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"404ctrl1 # [5897236.180653] ctrl1 systemd[1]: Started Name Service Cache Daemon (nsncd).405ctrl1 # [5897236.180738] ctrl1 systemd[1]: Reached target Host and Network Name Lookups.406ctrl1 # [5897236.180801] ctrl1 systemd[1]: Reached target User and Group Name Lookups.407ctrl1 # [5897236.244501] ctrl1 systemd[1]: Starting User Login Management...408peer1 # [5897236.046558] peer1 systemd[1]: Finished Import lastlog data into lastlog2 database.409peer1 # [5897236.176018] peer1 nsncd[197]: Aug 16 05:31:02.229 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"410peer1 # [5897236.176121] peer1 systemd[1]: Started Name Service Cache Daemon (nsncd).411peer1 # [5897236.176200] peer1 systemd[1]: Reached target Host and Network Name Lookups.412peer1 # [5897236.176255] peer1 systemd[1]: Reached target User and Group Name Lookups.413peer1 # [5897236.244545] peer1 systemd[1]: Starting User Login Management...414peer1 # [5897236.246096] peer1 systemd[1]: Starting Permit User Sessions...415peer1 # [5897236.260253] peer1 systemd[1]: Finished Permit User Sessions.416peer1 # [5897236.261404] peer1 systemd[1]: Started Console Getty.417peer1 # [5897236.261466] peer1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0418peer1 # [5897236.261490] peer1 systemd[1]: Reached target Login Prompts.419peer1 # [5897236.377665] peer1 dbus-broker-launch[198]: Looking up NSS user entry for 'systemd-timesync'...420peer3 # [5897236.045768] peer3 systemd[1]: Finished Import lastlog data into lastlog2 database.421peer3 # [5897236.168008] peer3 systemd[1]: Started Name Service Cache Daemon (nsncd).422peer3 # [5897236.168101] peer3 systemd[1]: Reached target Host and Network Name Lookups.423peer3 # [5897236.168155] peer3 systemd[1]: Reached target User and Group Name Lookups.424peer3 # [5897236.169696] peer3 nsncd[196]: Aug 16 05:31:02.222 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"425peer3 # [5897236.170348] peer3 systemd[1]: Starting User Login Management...426peer3 # [5897236.171657] peer3 systemd[1]: Starting Permit User Sessions...427peer3 # [5897236.252481] peer3 systemd[1]: Finished Permit User Sessions.428peer3 # [5897236.253643] peer3 systemd[1]: Started Console Getty.429peer3 # [5897236.253689] peer3 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0430peer3 # [5897236.253706] peer3 systemd[1]: Reached target Login Prompts.431peer2 # [5897236.186350] peer2 systemd[1]: Started Name Service Cache Daemon (nsncd).432peer2 # [5897236.188087] peer2 nsncd[197]: Aug 16 05:31:02.239 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"433peer2 # [5897236.186448] peer2 systemd[1]: Reached target Host and Network Name Lookups.434peer2 # [5897236.186519] peer2 systemd[1]: Reached target User and Group Name Lookups.435peer2 # [5897236.244527] peer2 systemd[1]: Starting User Login Management...436peer2 # [5897236.245868] peer2 systemd[1]: Starting Permit User Sessions...437peer2 # [5897236.257113] peer2 systemd[1]: Finished Permit User Sessions.438peer2 # [5897236.259047] peer2 systemd[1]: Started Console Getty.439peer2 # [5897236.259132] peer2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0440peer2 # [5897236.259178] peer2 systemd[1]: Reached target Login Prompts.441ctrl2 # [5897236.245738] ctrl2 systemd[1]: Starting Permit User Sessions...442ctrl2 # [5897236.259682] ctrl2 systemd[1]: Finished Permit User Sessions.443ctrl2 # [5897236.260765] ctrl2 systemd[1]: Started Console Getty.444ctrl2 # [5897236.260803] ctrl2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0445ctrl2 # [5897236.260819] ctrl2 systemd[1]: Reached target Login Prompts.446ctrl2 # [5897236.347312] ctrl2 dbus-broker-launch[200]: Looking up NSS user entry for 'systemd-timesync'...447ctrl2 # [5897236.349044] ctrl2 dbus-broker-launch[200]: NSS returned no entry for 'systemd-timesync'448ctrl2 # [5897236.349044] ctrl2 dbus-broker-launch[200]: Invalid user-name in /nix/store/rdlwxndn4mkd4kza7x4xcdplacddx1jm-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"449ctrl2 # [5897236.349610] ctrl2 systemd[1]: Started D-Bus System Message Bus.450ctrl2 # [5897236.356668] ctrl2 dbus-broker-launch[200]: Ready451ctrl1 # [5897236.245788] ctrl1 systemd[1]: Starting Permit User Sessions...452ctrl1 # [5897236.260232] ctrl1 systemd[1]: Finished Permit User Sessions.453ctrl1 # [5897236.261353] ctrl1 systemd[1]: Started Console Getty.454ctrl1 # [5897236.261397] ctrl1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0455ctrl1 # [5897236.261415] ctrl1 systemd[1]: Reached target Login Prompts.456ctrl1 # [5897236.337225] ctrl1 dbus-broker-launch[200]: Looking up NSS user entry for 'systemd-timesync'...457ctrl1 # [5897236.337950] ctrl1 dbus-broker-launch[200]: NSS returned no entry for 'systemd-timesync'458ctrl1 # [5897236.337950] ctrl1 dbus-broker-launch[200]: Invalid user-name in /nix/store/rdlwxndn4mkd4kza7x4xcdplacddx1jm-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"459ctrl1 # [5897236.338381] ctrl1 systemd[1]: Started D-Bus System Message Bus.460ctrl1 # [5897236.348826] ctrl1 dbus-broker-launch[200]: Ready461peer2 # [5897236.394393] peer2 dbus-broker-launch[201]: Looking up NSS user entry for 'systemd-timesync'...462peer2 # [5897236.395525] peer2 dbus-broker-launch[201]: NSS returned no entry for 'systemd-timesync'463peer2 # [5897236.395525] peer2 dbus-broker-launch[201]: Invalid user-name in /nix/store/rdlwxndn4mkd4kza7x4xcdplacddx1jm-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"464peer2 # [5897236.396138] peer2 systemd[1]: Started D-Bus System Message Bus.465peer2 # [5897236.405020] peer2 dbus-broker-launch[201]: Ready466peer3 # [5897236.380694] peer3 dbus-broker-launch[200]: Looking up NSS user entry for 'systemd-timesync'...467peer3 # [5897236.381708] peer3 dbus-broker-launch[200]: NSS returned no entry for 'systemd-timesync'468peer3 # [5897236.381708] peer3 dbus-broker-launch[200]: Invalid user-name in /nix/store/rdlwxndn4mkd4kza7x4xcdplacddx1jm-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"469peer3 # [5897236.382212] peer3 systemd[1]: Started D-Bus System Message Bus.470peer3 # [5897236.390788] peer3 dbus-broker-launch[200]: Ready471peer1 # [5897236.378520] peer1 dbus-broker-launch[198]: NSS returned no entry for 'systemd-timesync'472peer1 # [5897236.378520] peer1 dbus-broker-launch[198]: Invalid user-name in /nix/store/rdlwxndn4mkd4kza7x4xcdplacddx1jm-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"473peer1 # [5897236.379026] peer1 systemd[1]: Started D-Bus System Message Bus.474peer1 # [5897236.388311] peer1 dbus-broker-launch[198]: Ready475peer1 # [5897236.576161] peer1 systemd-networkd[191]: eth1: Gained IPv6LL476peer2 # [5897236.863961] peer2 systemd-logind[213]: New seat seat0.477peer2 # [5897236.864147] peer2 systemd[1]: Started User Login Management.478peer2 # [5897236.865534] peer2 systemd[1]: Starting linger-users.service...479peer2 # [5897236.885569] peer2 systemd[1]: linger-users.service: Deactivated successfully.480peer2 # [5897236.885775] peer2 systemd[1]: Finished linger-users.service.481peer2 # [5897236.886752] peer2 systemd[1]: Reached target Multi-User System.482peer3 # [5897236.863580] peer3 systemd-logind[210]: New seat seat0.483peer3 # [5897236.863765] peer3 systemd[1]: Started User Login Management.484peer3 # [5897236.865132] peer3 systemd[1]: Starting linger-users.service...485peer3 # [5897236.887169] peer3 systemd[1]: linger-users.service: Deactivated successfully.486peer3 # [5897236.887289] peer3 systemd[1]: Finished linger-users.service.487peer3 # [5897236.888110] peer3 systemd[1]: Reached target Multi-User System.488peer1 # [5897236.868989] peer1 systemd-logind[208]: New seat seat0.489peer1 # [5897236.869235] peer1 systemd[1]: Started User Login Management.490peer1 # [5897236.871253] peer1 systemd[1]: Starting linger-users.service...491peer1 # [5897236.886597] peer1 systemd[1]: linger-users.service: Deactivated successfully.492peer1 # [5897236.886802] peer1 systemd[1]: Finished linger-users.service.493peer1 # [5897236.887821] peer1 systemd[1]: Reached target Multi-User System.494ctrl1 # [5897236.897908] ctrl1 systemd-logind[210]: New seat seat0.495ctrl1 # [5897236.898212] ctrl1 systemd[1]: Started User Login Management.496ctrl1 # [5897236.900920] ctrl1 systemd[1]: Starting linger-users.service...497ctrl1 # [5897236.915360] ctrl1 systemd[1]: linger-users.service: Deactivated successfully.498ctrl1 # [5897236.915729] ctrl1 systemd[1]: Finished linger-users.service.499ctrl1 # [5897236.916144] ctrl1 systemd[1]: Reached target Multi-User System.500ctrl2 # [5897236.863590] ctrl2 systemd-logind[215]: New seat seat0.501ctrl2 # [5897236.864100] ctrl2 systemd[1]: Started User Login Management.502ctrl2 # [5897236.865249] ctrl2 systemd[1]: Starting linger-users.service...503ctrl2 # [5897236.887593] ctrl2 systemd[1]: linger-users.service: Deactivated successfully.504ctrl2 # [5897236.887668] ctrl2 systemd[1]: Finished linger-users.service.505ctrl2 # [5897236.888139] ctrl2 systemd[1]: Reached target Multi-User System.506ctrl1 # [5897237.252190] ctrl1 systemd-networkd[193]: eth1: Gained IPv6LL507peer2 # [5897237.184324] peer2 systemd-networkd[191]: eth1: Gained IPv6LL508ctrl2 # [5897237.440222] ctrl2 systemd-networkd[193]: eth1: Gained IPv6LL509peer3 # [5897237.632195] peer3 systemd-networkd[190]: eth1: Gained IPv6LL510peer1: still waiting for container 'peer1' to reach ready state...511peer1: still waiting for container 'peer1' to reach ready state...512peer1: still waiting for container 'peer1' to reach ready state...513peer1: still waiting for container 'peer1' to reach ready state...514peer1: still waiting for container 'peer1' to reach ready state...515peer1: still waiting for container 'peer1' to reach ready state...516peer1: still waiting for container 'peer1' to reach ready state...517peer1: still waiting for container 'peer1' to reach ready state...518peer1: still waiting for container 'peer1' to reach ready state...519ctrl2 # [5897325.028811] ctrl2 systemd[1]: systemd-machine-id-commit.service: start operation timed out. Terminating.520peer1 # [5897324.917823] peer1 systemd[1]: systemd-machine-id-commit.service: start operation timed out. Terminating.521peer2 # [5897324.915354] peer2 systemd[1]: systemd-machine-id-commit.service: start operation timed out. Terminating.522ctrl1 # [5897325.105438] ctrl1 systemd[1]: systemd-machine-id-commit.service: start operation timed out. Terminating.523peer3 # [5897324.916585] peer3 systemd[1]: systemd-machine-id-commit.service: start operation timed out. Terminating.524peer1: still waiting for container 'peer1' to reach ready state...525peer1: still waiting for container 'peer1' to reach ready state...526peer1: still waiting for container 'peer1' to reach ready state...527peer1: still waiting for container 'peer1' to reach ready state...528peer1: waiting for unit network-online.target529peer1: (finished: waiting for unit network-online.target, in 0.02 seconds)530peer1: waiting for unit systemd-networkd.service531peer1: (finished: waiting for unit systemd-networkd.service, in 0.02 seconds)532peer2: waiting for unit network-online.target533peer2: (finished: waiting for unit network-online.target, in 0.02 seconds)534peer2: waiting for unit systemd-networkd.service535peer2: (finished: waiting for unit systemd-networkd.service, in 0.02 seconds)536peer3: waiting for unit network-online.target537peer3: (finished: waiting for unit network-online.target, in 0.02 seconds)538peer3: waiting for unit systemd-networkd.service539peer3: (finished: waiting for unit systemd-networkd.service, in 0.02 seconds)540ctrl1: waiting for unit network-online.target541ctrl2 # [5897370.191893] ctrl2 systemd[1]: systemd-machine-id-commit.service: Main process exited, code=killed, status=15/TERM542ctrl2 # [5897370.192070] ctrl2 systemd[1]: systemd-machine-id-commit.service: Failed with result 'timeout'.543ctrl2 # [5897370.192269] ctrl2 systemd[1]: Failed to start Save Transient machine-id to Disk.544ctrl2 # [5897370.192886] ctrl2 systemd[1]: Startup finished in 2min 15.841s.545ctrl2 # [5897370.400510] ctrl2 systemd[1]: Reached target Network is Online.546ctrl1: (finished: waiting for unit network-online.target, in 0.02 seconds)547ctrl1: waiting for unit systemd-networkd.service548ctrl1: (finished: waiting for unit systemd-networkd.service, in 0.02 seconds)549ctrl2: waiting for unit network-online.target550ctrl2: (finished: waiting for unit network-online.target, in 0.01 seconds)551ctrl2: waiting for unit systemd-networkd.service552ctrl2: (finished: waiting for unit systemd-networkd.service, in 0.01 seconds)553554555============================================================556STARTING PING TESTS557============================================================558559--- Pinging from peer1 to peer2.wg-test-one ---560peer1: waiting for success: ping -c1 peer2.wg-test-one >&2561PING peer2.wg-test-one (fd51:19c1:89:500:3b21:3ced:3e:89b3) 56 data bytes56264 bytes from peer2.wg-test-one (fd51:19c1:89:500:3b21:3ced:3e:89b3): icmp_seq=1 ttl=63 time=0.624 ms563564--- peer2.wg-test-one ping statistics ---5651 packets transmitted, 1 received, 0% packet loss, time 0ms566rtt min/avg/max/mdev = 0.624/0.624/0.624/0.000 ms567peer1: (finished: waiting for success: ping -c1 peer2.wg-test-one >&2, in 0.02 seconds)568569--- Pinging from peer1 to peer3.wg-test-one ---570peer1: waiting for success: ping -c1 peer3.wg-test-one >&2571ctrl1 # [5897370.191923] ctrl1 systemd[1]: systemd-machine-id-commit.service: Main process exited, code=killed, status=15/TERM572ctrl1 # [5897370.192106] ctrl1 systemd[1]: systemd-machine-id-commit.service: Failed with result 'timeout'.573ctrl1 # [5897370.192352] ctrl1 systemd[1]: Failed to start Save Transient machine-id to Disk.574ctrl1 # [5897370.192830] ctrl1 systemd[1]: Startup finished in 2min 15.840s.575ctrl1 # [5897370.384965] ctrl1 systemd[1]: Reached target Network is Online.576PING peer3.wg-test-one (fd51:19c1:e:fb00:e42b:bf85:33f4:f0b1) 56 data bytes57764 bytes from peer3.wg-test-one (fd51:19c1:e:fb00:e42b:bf85:33f4:f0b1): icmp_seq=1 ttl=63 time=0.618 ms578579--- peer3.wg-test-one ping statistics ---5801 packets transmitted, 1 received, 0% packet loss, time 0ms581rtt min/avg/max/mdev = 0.618/0.618/0.618/0.000 ms582peer1: (finished: waiting for success: ping -c1 peer3.wg-test-one >&2, in 0.01 seconds)583584--- Pinging from peer1 to ctrl1.wg-test-one ---585peer1: waiting for success: ping -c1 ctrl1.wg-test-one >&2586PING ctrl1.wg-test-one (fd51:19c1:e:fb00::1) 56 data bytes58764 bytes from ctrl1.wg-test-one (fd51:19c1:e:fb00::1): icmp_seq=1 ttl=64 time=0.203 ms588589--- ctrl1.wg-test-one ping statistics ---5901 packets transmitted, 1 received, 0% packet loss, time 0ms591rtt min/avg/max/mdev = 0.203/0.203/0.203/0.000 ms592peer1: (finished: waiting for success: ping -c1 ctrl1.wg-test-one >&2, in 0.01 seconds)593594--- Pinging from peer1 to ctrl2.wg-test-one ---595peer1: waiting for success: ping -c1 ctrl2.wg-test-one >&2596PING ctrl2.wg-test-one (fd51:19c1:89:500::1) 56 data bytes59764 bytes from ctrl2.wg-test-one (fd51:19c1:89:500::1): icmp_seq=1 ttl=64 time=0.202 ms598599--- ctrl2.wg-test-one ping statistics ---6001 packets transmitted, 1 received, 0% packet loss, time 0ms601rtt min/avg/max/mdev = 0.202/0.202/0.202/0.000 ms602peer1: (finished: waiting for success: ping -c1 ctrl2.wg-test-one >&2, in 0.01 seconds)603604--- Pinging from peer2 to peer1.wg-test-one ---605peer2: waiting for success: ping -c1 peer1.wg-test-one >&2606PING peer1.wg-test-one (fd51:19c1:e:fb00:6987:50a0:9b93:4337) 56 data bytes60764 bytes from peer1.wg-test-one (fd51:19c1:e:fb00:6987:50a0:9b93:4337): icmp_seq=1 ttl=63 time=0.587 ms608609--- peer1.wg-test-one ping statistics ---6101 packets transmitted, 1 received, 0% packet loss, time 0ms611rtt min/avg/max/mdev = 0.587/0.587/0.587/0.000 ms612peer2: (finished: waiting for success: ping -c1 peer1.wg-test-one >&2, in 0.01 seconds)613614--- Pinging from peer2 to peer3.wg-test-one ---615peer2: waiting for success: ping -c1 peer3.wg-test-one >&2616PING peer3.wg-test-one (fd51:19c1:e:fb00:e42b:bf85:33f4:f0b1) 56 data bytes61764 bytes from peer3.wg-test-one (fd51:19c1:e:fb00:e42b:bf85:33f4:f0b1): icmp_seq=1 ttl=63 time=1.12 ms618619--- peer3.wg-test-one ping statistics ---6201 packets transmitted, 1 received, 0% packet loss, time 0ms621rtt min/avg/max/mdev = 1.117/1.117/1.117/0.000 ms622peer2: (finished: waiting for success: ping -c1 peer3.wg-test-one >&2, in 0.01 seconds)623624--- Pinging from peer2 to ctrl1.wg-test-one ---625peer2: waiting for success: ping -c1 ctrl1.wg-test-one >&2626peer2 # [5897370.191961] peer2 systemd[1]: systemd-machine-id-commit.service: Main process exited, code=killed, status=15/TERM627peer2 # [5897370.192152] peer2 systemd[1]: systemd-machine-id-commit.service: Failed with result 'timeout'.628peer2 # [5897370.192393] peer2 systemd[1]: Failed to start Save Transient machine-id to Disk.629peer2 # [5897370.192878] peer2 systemd[1]: Startup finished in 2min 15.821s.630peer2 # [5897370.357624] peer2 systemd[1]: Reached target Network is Online.631peer3 # [5897370.190432] peer3 systemd[1]: systemd-machine-id-commit.service: Main process exited, code=killed, status=15/TERM632peer3 # [5897370.190498] peer3 systemd[1]: systemd-machine-id-commit.service: Failed with result 'timeout'.633peer3 # [5897370.190699] peer3 systemd[1]: Failed to start Save Transient machine-id to Disk.634peer3 # [5897370.191289] peer3 systemd[1]: Startup finished in 2min 15.819s.635peer3 # [5897370.191853] peer3 systemd[1]: systemd-machine-id-commit.service: Consumed 3.078s CPU time over 2min 15.308s wall clock time.636peer3 # [5897370.371451] peer3 systemd[1]: Reached target Network is Online.637peer1 # [5897370.191939] peer1 systemd[1]: systemd-machine-id-commit.service: Main process exited, code=killed, status=15/TERM638peer1 # [5897370.192139] peer1 systemd[1]: systemd-machine-id-commit.service: Failed with result 'timeout'.639peer1 # [5897370.192406] peer1 systemd[1]: Failed to start Save Transient machine-id to Disk.640peer1 # [5897370.192885] peer1 systemd[1]: Startup finished in 2min 15.837s.641peer1 # [5897370.340763] peer1 systemd[1]: Reached target Network is Online.642PING ctrl1.wg-test-one (fd51:19c1:e:fb00::1) 56 data bytes64364 bytes from ctrl1.wg-test-one (fd51:19c1:e:fb00::1): icmp_seq=1 ttl=64 time=0.269 ms644645--- ctrl1.wg-test-one ping statistics ---6461 packets transmitted, 1 received, 0% packet loss, time 0ms647rtt min/avg/max/mdev = 0.269/0.269/0.269/0.000 ms648peer2: (finished: waiting for success: ping -c1 ctrl1.wg-test-one >&2, in 0.01 seconds)649650--- Pinging from peer2 to ctrl2.wg-test-one ---651peer2: waiting for success: ping -c1 ctrl2.wg-test-one >&2652PING ctrl2.wg-test-one (fd51:19c1:89:500::1) 56 data bytes65364 bytes from ctrl2.wg-test-one (fd51:19c1:89:500::1): icmp_seq=1 ttl=64 time=0.266 ms654655--- ctrl2.wg-test-one ping statistics ---6561 packets transmitted, 1 received, 0% packet loss, time 0ms657rtt min/avg/max/mdev = 0.266/0.266/0.266/0.000 ms658peer2: (finished: waiting for success: ping -c1 ctrl2.wg-test-one >&2, in 0.01 seconds)659660--- Pinging from peer3 to peer1.wg-test-one ---661peer3: waiting for success: ping -c1 peer1.wg-test-one >&2662PING peer1.wg-test-one (fd51:19c1:e:fb00:6987:50a0:9b93:4337) 56 data bytes66364 bytes from peer1.wg-test-one (fd51:19c1:e:fb00:6987:50a0:9b93:4337): icmp_seq=1 ttl=63 time=0.464 ms664665--- peer1.wg-test-one ping statistics ---6661 packets transmitted, 1 received, 0% packet loss, time 0ms667rtt min/avg/max/mdev = 0.464/0.464/0.464/0.000 ms668peer3: (finished: waiting for success: ping -c1 peer1.wg-test-one >&2, in 0.01 seconds)669670--- Pinging from peer3 to peer2.wg-test-one ---671peer3: waiting for success: ping -c1 peer2.wg-test-one >&2672PING peer2.wg-test-one (fd51:19c1:89:500:3b21:3ced:3e:89b3) 56 data bytes67364 bytes from peer2.wg-test-one (fd51:19c1:89:500:3b21:3ced:3e:89b3): icmp_seq=1 ttl=63 time=0.480 ms674675--- peer2.wg-test-one ping statistics ---6761 packets transmitted, 1 received, 0% packet loss, time 0ms677rtt min/avg/max/mdev = 0.480/0.480/0.480/0.000 ms678peer3: (finished: waiting for success: ping -c1 peer2.wg-test-one >&2, in 0.01 seconds)679680--- Pinging from peer3 to ctrl1.wg-test-one ---681peer3: waiting for success: ping -c1 ctrl1.wg-test-one >&2682PING ctrl1.wg-test-one (fd51:19c1:e:fb00::1) 56 data bytes68364 bytes from ctrl1.wg-test-one (fd51:19c1:e:fb00::1): icmp_seq=1 ttl=64 time=0.210 ms684685--- ctrl1.wg-test-one ping statistics ---6861 packets transmitted, 1 received, 0% packet loss, time 0ms687rtt min/avg/max/mdev = 0.210/0.210/0.210/0.000 ms688peer3: (finished: waiting for success: ping -c1 ctrl1.wg-test-one >&2, in 0.01 seconds)689690--- Pinging from peer3 to ctrl2.wg-test-one ---691peer3: waiting for success: ping -c1 ctrl2.wg-test-one >&2692PING ctrl2.wg-test-one (fd51:19c1:89:500::1) 56 data bytes69364 bytes from ctrl2.wg-test-one (fd51:19c1:89:500::1): icmp_seq=1 ttl=64 time=0.219 ms694695--- ctrl2.wg-test-one ping statistics ---6961 packets transmitted, 1 received, 0% packet loss, time 0ms697rtt min/avg/max/mdev = 0.219/0.219/0.219/0.000 ms698peer3: (finished: waiting for success: ping -c1 ctrl2.wg-test-one >&2, in 0.01 seconds)699700--- Pinging from ctrl1 to peer1.wg-test-one ---701ctrl1: waiting for success: ping -c1 peer1.wg-test-one >&2702PING peer1.wg-test-one (fd51:19c1:e:fb00:6987:50a0:9b93:4337) 56 data bytes70364 bytes from peer1.wg-test-one (fd51:19c1:e:fb00:6987:50a0:9b93:4337): icmp_seq=1 ttl=64 time=0.179 ms704705--- peer1.wg-test-one ping statistics ---7061 packets transmitted, 1 received, 0% packet loss, time 0ms707rtt min/avg/max/mdev = 0.179/0.179/0.179/0.000 ms708ctrl1: (finished: waiting for success: ping -c1 peer1.wg-test-one >&2, in 0.01 seconds)709710--- Pinging from ctrl1 to peer2.wg-test-one ---711ctrl1: waiting for success: ping -c1 peer2.wg-test-one >&2712PING peer2.wg-test-one (fd51:19c1:89:500:3b21:3ced:3e:89b3) 56 data bytes71364 bytes from peer2.wg-test-one (fd51:19c1:89:500:3b21:3ced:3e:89b3): icmp_seq=1 ttl=64 time=0.287 ms714715--- peer2.wg-test-one ping statistics ---7161 packets transmitted, 1 received, 0% packet loss, time 0ms717rtt min/avg/max/mdev = 0.287/0.287/0.287/0.000 ms718ctrl1: (finished: waiting for success: ping -c1 peer2.wg-test-one >&2, in 0.01 seconds)719720--- Pinging from ctrl1 to peer3.wg-test-one ---721ctrl1: waiting for success: ping -c1 peer3.wg-test-one >&2722PING peer3.wg-test-one (fd51:19c1:e:fb00:e42b:bf85:33f4:f0b1) 56 data bytes72364 bytes from peer3.wg-test-one (fd51:19c1:e:fb00:e42b:bf85:33f4:f0b1): icmp_seq=1 ttl=64 time=0.210 ms724725--- peer3.wg-test-one ping statistics ---7261 packets transmitted, 1 received, 0% packet loss, time 0ms727rtt min/avg/max/mdev = 0.210/0.210/0.210/0.000 ms728ctrl1: (finished: waiting for success: ping -c1 peer3.wg-test-one >&2, in 0.01 seconds)729730--- Pinging from ctrl1 to ctrl2.wg-test-one ---731ctrl1: waiting for success: ping -c1 ctrl2.wg-test-one >&2732PING ctrl2.wg-test-one (fd51:19c1:89:500::1) 56 data bytes73364 bytes from ctrl2.wg-test-one (fd51:19c1:89:500::1): icmp_seq=1 ttl=64 time=5.52 ms734735--- ctrl2.wg-test-one ping statistics ---7361 packets transmitted, 1 received, 0% packet loss, time 0ms737rtt min/avg/max/mdev = 5.515/5.515/5.515/0.000 ms738ctrl1: (finished: waiting for success: ping -c1 ctrl2.wg-test-one >&2, in 0.02 seconds)739740--- Pinging from ctrl2 to peer1.wg-test-one ---741ctrl2: waiting for success: ping -c1 peer1.wg-test-one >&2742PING peer1.wg-test-one (fd51:19c1:e:fb00:6987:50a0:9b93:4337) 56 data bytes74364 bytes from peer1.wg-test-one (fd51:19c1:e:fb00:6987:50a0:9b93:4337): icmp_seq=1 ttl=64 time=0.398 ms744745--- peer1.wg-test-one ping statistics ---7461 packets transmitted, 1 received, 0% packet loss, time 0ms747rtt min/avg/max/mdev = 0.398/0.398/0.398/0.000 ms748ctrl2: (finished: waiting for success: ping -c1 peer1.wg-test-one >&2, in 0.01 seconds)749750--- Pinging from ctrl2 to peer2.wg-test-one ---751ctrl2: waiting for success: ping -c1 peer2.wg-test-one >&2752PING peer2.wg-test-one (fd51:19c1:89:500:3b21:3ced:3e:89b3) 56 data bytes75364 bytes from peer2.wg-test-one (fd51:19c1:89:500:3b21:3ced:3e:89b3): icmp_seq=1 ttl=64 time=0.256 ms754755--- peer2.wg-test-one ping statistics ---7561 packets transmitted, 1 received, 0% packet loss, time 0ms757rtt min/avg/max/mdev = 0.256/0.256/0.256/0.000 ms758ctrl2: (finished: waiting for success: ping -c1 peer2.wg-test-one >&2, in 0.01 seconds)759760--- Pinging from ctrl2 to peer3.wg-test-one ---761ctrl2: waiting for success: ping -c1 peer3.wg-test-one >&2762PING peer3.wg-test-one (fd51:19c1:e:fb00:e42b:bf85:33f4:f0b1) 56 data bytes76364 bytes from peer3.wg-test-one (fd51:19c1:e:fb00:e42b:bf85:33f4:f0b1): icmp_seq=1 ttl=64 time=0.260 ms764765--- peer3.wg-test-one ping statistics ---7661 packets transmitted, 1 received, 0% packet loss, time 0ms767rtt min/avg/max/mdev = 0.260/0.260/0.260/0.000 ms768ctrl2: (finished: waiting for success: ping -c1 peer3.wg-test-one >&2, in 0.01 seconds)769770--- Pinging from ctrl2 to ctrl1.wg-test-one ---771ctrl2: waiting for success: ping -c1 ctrl1.wg-test-one >&2772PING ctrl1.wg-test-one (fd51:19c1:e:fb00::1) 56 data bytes77364 bytes from ctrl1.wg-test-one (fd51:19c1:e:fb00::1): icmp_seq=1 ttl=64 time=0.231 ms774775--- ctrl1.wg-test-one ping statistics ---7761 packets transmitted, 1 received, 0% packet loss, time 0ms777rtt min/avg/max/mdev = 0.231/0.231/0.231/0.000 ms778ctrl2: (finished: waiting for success: ping -c1 ctrl1.wg-test-one >&2, in 0.01 seconds)779(finished: run the VM test script, in 137.20 seconds)780test script finished in 137.55s781cleanup782kill NspawnMachine (pid 55)783kill NspawnMachine (pid 54)784Container ctrl1 terminated by signal KILL.785kill NspawnMachine (pid 57)786Container ctrl2 terminated by signal KILL.787Container peer1 terminated by signal KILL.788kill NspawnMachine (pid 63)789kill NspawnMachine (pid 65)790Container peer2 terminated by signal KILL.791Container peer3 terminated by signal KILL.792(finished: cleanup, in 0.92 seconds)