container-test-run-user-firewall-nftables
checks.aarch64-linux.nixos-test-user-firewall-nftables
· build #964
· raw
1build01: building 7116xgwh0kdcxyvxp39fx0g6hyfx3mdm-container-test-run-user-firewall-nftables.drv2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.11 seconds)56Test will time out and terminate in 3600.0 seconds7run the VM test script8additionally exposed symbols:9 machine, router,10 vlan1,11 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_ssh12start all VMs13machine: systemd-nspawn running (pid 52)14router: systemd-nspawn running (pid 54)15machine: Waiting for journal at /build/vm-state-machine/var/log/journal...16router: Waiting for journal at /build/vm-state-router/var/log/journal...17(finished: start all VMs, in 0.00 seconds)18router: waiting for unit multi-user.target19nixos-nspawn(machine): TAP vde-tap1 not found; container will be isolated from VDE20nixos-nspawn(machine): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths.21nixos-nspawn(router): TAP vde-tap1 not found; container will be isolated from VDE22nixos-nspawn(router): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths.23Note: 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.24░ Spawning container machine on /build/vm-state-machine.25Note: 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.26░ Spawning container router on /build/vm-state-router.27router # No journal files were found.28router # No journal boot entry found for the specified boot (+0).29machine # No journal files were found.30machine # No journal boot entry found for the specified boot (+0).31router # [361284.664556] router systemd-journald[57]: Journal started32router # [361284.664622] router systemd-journald[57]: Runtime Journal (/run/log/journal/9775e7621ecc474781b158ea5cb33da0) is 8M, max 2.5G, 2.4G free.33router # [361284.671977] router systemd[1]: Finished Apply Kernel Variables.34router # [361284.683849] router systemd[1]: Finished Create Static Device Nodes in /dev gracefully.35router # [361284.696947] router systemd[1]: Starting Flush Journal to Persistent Storage...36router # [361284.697809] router systemd[1]: Starting Network Name Resolution...37router # [361284.698782] router systemd[1]: Starting Create Static Device Nodes in /dev...38router # [361284.709122] router systemd-journald[57]: Time spent on flushing to /var/log/journal/9775e7621ecc474781b158ea5cb33da0 is 1.168ms for 7 entries.39router # [361284.709122] router systemd-journald[57]: System Journal (/var/log/journal/9775e7621ecc474781b158ea5cb33da0) is 8M, max 4G, 3.9G free.40router # [361284.726078] router systemd[1]: Finished Create Static Device Nodes in /dev.41router # [361284.726746] router systemd[1]: Reached target Preparation for Local File Systems.42router # [361284.726854] router systemd[1]: Reached target Local File Systems.43router # [361284.727711] router systemd[1]: Listening on Boot Loader Control Service Socket.44router # [361284.727766] router systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container45router # [361284.728669] router systemd[1]: Starting Save Transient machine-id to Disk...46router # [361284.728709] router systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys47router # [361284.729690] router systemd[1]: Starting Network Management...48router # [361284.784962] router systemd[1]: Finished Flush Journal to Persistent Storage.49router # [361284.786655] router systemd[1]: Starting Create System Files and Directories...50router # [361284.803497] router systemd-tmpfiles[73]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted51router # [361284.803715] router systemd-tmpfiles[73]: fchmod() of /var/log/journal failed: Operation not permitted52router # [361284.803863] router systemd-tmpfiles[73]: fchmod() of /var/log/journal/9775e7621ecc474781b158ea5cb33da0 failed: Operation not permitted53router # [361284.804218] router systemd-tmpfiles[73]: fchmod() of /run/log/journal failed: Operation not permitted54router # [361284.805670] router systemd[1]: Finished Create System Files and Directories.55router # [361284.806720] router systemd[1]: Starting Rebuild Journal Catalog...56router # [361284.807459] router systemd[1]: Starting Record System Boot/Shutdown in UTMP...57router # [361284.820311] router systemd[1]: Finished Record System Boot/Shutdown in UTMP.58router # [361284.826095] router systemd[1]: Finished Rebuild Journal Catalog.59router # [361284.827169] router systemd[1]: Starting Update is Completed...60router # [361284.837805] router systemd[1]: Finished Update is Completed.61router # [361285.413238] router systemd-networkd[69]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted62router # [361285.413338] router systemd-networkd[69]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted63router # [361285.422603] router systemd-networkd[69]: lo: Link UP64router # [361285.422611] router systemd-networkd[69]: lo: Gained carrier65router # [361285.422812] router systemd-networkd[69]: eth1: Configuring with /etc/systemd/network/40-eth1.network.66router # [361285.423159] router systemd[1]: Started Network Management.67router # [361285.423297] router systemd-networkd[69]: eth1: Link UP68router # [361285.423632] router systemd-networkd[69]: eth1: Gained carrier69router # [361285.424270] router systemd[1]: Starting Enable Persistent Storage in systemd-networkd...70router # [361285.490155] router systemd[1]: Finished Enable Persistent Storage in systemd-networkd.71machine # [361284.674471] machine systemd-journald[57]: Journal started72machine # [361284.674534] machine systemd-journald[57]: Runtime Journal (/run/log/journal/8450fc8e147e4eacb9f014e94d88e215) is 8M, max 2.5G, 2.4G free.73machine # [361284.682873] machine systemd[1]: Finished Apply Kernel Variables.74machine # [361284.696491] machine systemd[1]: Finished Create Static Device Nodes in /dev gracefully.75machine # [361284.716990] machine systemd[1]: Starting Flush Journal to Persistent Storage...76machine # [361284.717760] machine systemd[1]: Starting Create Static Device Nodes in /dev...77machine # [361284.726439] machine systemd-journald[57]: Time spent on flushing to /var/log/journal/8450fc8e147e4eacb9f014e94d88e215 is 1.217ms for 6 entries.78machine # [361284.726439] machine systemd-journald[57]: System Journal (/var/log/journal/8450fc8e147e4eacb9f014e94d88e215) is 8M, max 4G, 3.9G free.79machine # [361284.735935] machine systemd[1]: Finished Create Static Device Nodes in /dev.80machine # [361284.736640] machine systemd[1]: Reached target Preparation for Local File Systems.81machine # [361284.736756] machine systemd[1]: Reached target Local File Systems.82machine # [361284.737626] machine systemd[1]: Listening on Boot Loader Control Service Socket.83machine # [361284.737675] machine systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container84machine # [361284.738711] machine systemd[1]: Starting Save Transient machine-id to Disk...85machine # [361284.738751] machine systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys86machine # [361284.797200] machine systemd[1]: Finished Flush Journal to Persistent Storage.87machine # [361284.800118] machine systemd[1]: Starting Create System Files and Directories...88machine # [361284.818280] machine systemd-tmpfiles[69]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted89machine # [361284.818499] machine systemd-tmpfiles[69]: fchmod() of /var/log/journal failed: Operation not permitted90machine # [361284.818648] machine systemd-tmpfiles[69]: fchmod() of /var/log/journal/8450fc8e147e4eacb9f014e94d88e215 failed: Operation not permitted91machine # [361284.818870] machine systemd-tmpfiles[69]: fchmod() of /run/log/journal failed: Operation not permitted92machine # [361284.820299] machine systemd[1]: Finished Create System Files and Directories.93machine # [361284.821390] machine systemd[1]: Starting Rebuild Journal Catalog...94machine # [361284.822194] machine systemd[1]: Starting Record System Boot/Shutdown in UTMP...95machine # [361284.837549] machine systemd[1]: Finished Record System Boot/Shutdown in UTMP.96machine # [361284.845547] machine systemd[1]: Finished Rebuild Journal Catalog.97machine # [361284.847348] machine systemd[1]: Starting Update is Completed...98machine # [361284.857752] machine systemd[1]: Finished Update is Completed.99machine # [361284.857919] machine systemd[1]: Reached target System Initialization.100machine # [361284.858007] machine systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container101machine # [361284.858045] machine systemd[1]: Started Daily Cleanup of Temporary Directories.102machine # [361284.858064] machine systemd[1]: Reached target Timer Units.103machine # [361284.858176] machine systemd[1]: Listening on D-Bus System Message Bus Socket.104machine # [361284.858296] machine systemd[1]: Listening on Nix Daemon Socket.105machine # [361284.858395] machine systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.106machine # [361284.858420] machine systemd[1]: Reached target Socket Units.107machine # [361284.858450] machine systemd[1]: Reached target Basic System.108machine # [361284.859530] machine systemd[1]: Starting Import lastlog data into lastlog2 database...109machine # [361284.860299] machine systemd[1]: Starting nftables firewall...110machine # [361284.861153] machine systemd[1]: Starting Name Service Cache Daemon (nsncd)...111machine # [361284.879958] machine systemd[1]: Finished Import lastlog data into lastlog2 database.112machine # [361284.997811] machine nsncd[79]: Oct 13 15:26:27.955 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"113machine # [361284.997812] machine systemd[1]: Started Name Service Cache Daemon (nsncd).114machine # [361284.997892] machine systemd[1]: Reached target Host and Network Name Lookups.115machine # [361284.997954] machine systemd[1]: Reached target User and Group Name Lookups.116machine # [361284.999290] machine systemd[1]: Starting User Login Management...117machine # [361285.002139] machine systemd[1]: Finished nftables firewall.118machine # [361285.002313] machine systemd[1]: Reached target Preparation for Network.119machine # [361285.003278] machine systemd[1]: Starting Address configuration of eth1...120machine # [361285.004374] machine systemd[1]: Starting Extra networking commands....121machine # [361285.005148] machine systemd[1]: Starting Setup wg0 dummy interface...122machine # [361285.019919] machine network-addresses-eth1-start[105]: adding address 192.168.1.1/24... done123machine # [361285.022455] machine network-addresses-eth1-start[105]: adding address 2001:db8:1::1/64... done124machine # [361285.024067] machine systemd[1]: Finished Setup wg0 dummy interface.125machine # [361285.026467] machine systemd[1]: Finished Address configuration of eth1.126machine # [361285.061645] machine systemd[1]: Stopped target Host and Network Name Lookups.127machine # [361285.061708] machine systemd[1]: Stopping Host and Network Name Lookups...128machine # [361285.061748] machine systemd[1]: Stopped target User and Group Name Lookups.129machine # [361285.061771] machine systemd[1]: Stopping User and Group Name Lookups...130machine # [361285.061955] machine systemd[1]: Stopping Name Service Cache Daemon (nsncd)...131machine # [361285.068184] machine systemd[1]: nscd.service: Deactivated successfully.132machine # [361285.068386] machine systemd[1]: Stopped Name Service Cache Daemon (nsncd).133machine # [361285.070714] machine systemd[1]: Starting Name Service Cache Daemon (nsncd)...134machine # [361285.112224] machine systemd[1]: Finished Extra networking commands..135machine # [361285.112503] machine systemd[1]: Reached target Network.136machine # [361285.113648] machine systemd[1]: Starting Nginx Web Server...137machine # [361285.270939] machine nsncd[179]: Oct 13 15:26:28.228 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"138machine # [361285.270887] machine systemd[1]: Started Name Service Cache Daemon (nsncd).139machine # [361285.270956] machine systemd[1]: Reached target Host and Network Name Lookups.140machine # [361285.271026] machine systemd[1]: Reached target User and Group Name Lookups.141machine # [361285.272314] machine systemd[1]: Starting Permit User Sessions...142machine # [361285.339426] machine systemd[1]: Finished Permit User Sessions.143machine # [361285.341134] machine systemd[1]: Started Console Getty.144machine # [361285.341202] machine systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0145machine # [361285.341240] machine systemd[1]: Reached target Login Prompts.146machine # [361285.823647] machine systemd-logind[102]: New seat seat0.147machine # [361285.824533] machine systemd[1]: Starting D-Bus System Message Bus...148machine # [361285.824647] machine systemd[1]: Started User Login Management.149machine # [361285.825461] machine systemd[1]: Starting linger-users.service...150machine # [361285.889463] machine systemd[1]: linger-users.service: Deactivated successfully.151machine # [361285.889819] machine systemd[1]: Finished linger-users.service.152machine # [361286.030044] machine nginx-pre-start[205]: nginx: the configuration file /nix/store/rbrd4r9lh3iq8rkq3ciiriyvjx160fh7-nginx.conf syntax is ok153machine # [361286.030443] machine nginx-pre-start[205]: nginx: configuration file /nix/store/rbrd4r9lh3iq8rkq3ciiriyvjx160fh7-nginx.conf test is successful154machine # [361286.035804] machine systemd[1]: Started Nginx Web Server.155machine # [361286.035997] machine systemd[1]: Reached target Multi-User System.156router # [361285.884951] router systemd-resolved[64]: Positive Trust Anchors:157router # [361285.884964] router systemd-resolved[64]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d158router # [361285.884968] router systemd-resolved[64]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16159router # [361285.885003] router systemd-resolved[64]: 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 test160router # [361285.906087] router systemd-resolved[64]: Using system hostname 'router'.161router # [361285.907495] router systemd[1]: Started Network Name Resolution.162router # [361285.907593] router systemd[1]: Reached target Network.163router # [361285.907678] router systemd[1]: Reached target System Initialization.164router # [361285.907733] router systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container165router # [361285.907763] router systemd[1]: Started Daily Cleanup of Temporary Directories.166router # [361285.907790] router systemd[1]: Reached target Timer Units.167router # [361285.907946] router systemd[1]: Listening on D-Bus System Message Bus Socket.168router # [361285.908121] router systemd[1]: Listening on Nix Daemon Socket.169router # [361285.908256] router systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.170router # [361285.908284] router systemd[1]: Reached target Socket Units.171router # [361285.908338] router systemd[1]: Reached target Basic System.172router # [361285.909613] router systemd[1]: Starting Import lastlog data into lastlog2 database...173router # [361285.910563] router systemd[1]: Starting Nginx Web Server...174router # [361285.911443] router systemd[1]: Starting Name Service Cache Daemon (nsncd)...175router # [361285.912753] router systemd[1]: Starting D-Bus System Message Bus...176router # [361285.930455] router systemd[1]: Finished Import lastlog data into lastlog2 database.177router # [361286.068300] router systemd[1]: Started Name Service Cache Daemon (nsncd).178router # [361286.068373] router systemd[1]: Reached target Host and Network Name Lookups.179router # [361286.068535] router nsncd[86]: Oct 13 15:26:29.025 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"180router # [361286.068451] router systemd[1]: Reached target User and Group Name Lookups.181router # [361286.080418] router systemd[1]: Starting User Login Management...182router # [361286.081814] router systemd[1]: Starting Permit User Sessions...183router # [361286.097385] router systemd[1]: Finished Permit User Sessions.184router # [361286.098528] router systemd[1]: Started Console Getty.185router # [361286.098574] router systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0186router # [361286.098601] router systemd[1]: Reached target Login Prompts.187machine # [361286.176785] machine dbus-broker-launch[201]: Looking up NSS user entry for 'systemd-timesync'...188machine # [361286.177818] machine dbus-broker-launch[201]: NSS returned no entry for 'systemd-timesync'189machine # [361286.177818] machine dbus-broker-launch[201]: Invalid user-name in /nix/store/z04n9h3rwfqyffnc886glf57frs8idgk-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"190machine # [361286.178342] machine systemd[1]: Started D-Bus System Message Bus.191machine # [361286.186479] machine dbus-broker-launch[201]: Ready192router # [361286.227943] router dbus-broker-launch[87]: Looking up NSS user entry for 'systemd-timesync'...193router # [361286.228868] router dbus-broker-launch[87]: NSS returned no entry for 'systemd-timesync'194router # [361286.228868] router dbus-broker-launch[87]: Invalid user-name in /nix/store/99ngr5ck174ncqg45shbgx0crbkdsn94-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"195router # [361286.231732] router systemd[1]: Started D-Bus System Message Bus.196router # [361286.238308] router dbus-broker-launch[87]: Ready197router # [361286.816200] router systemd-networkd[69]: eth1: Gained IPv6LL198router # [361286.878840] router nginx-pre-start[116]: nginx: the configuration file /nix/store/c6kyqxh5q3bfawa27n0rqih6f6fa1paj-nginx.conf syntax is ok199router # [361286.879227] router nginx-pre-start[116]: nginx: configuration file /nix/store/c6kyqxh5q3bfawa27n0rqih6f6fa1paj-nginx.conf test is successful200router # [361286.891050] router systemd[1]: Started Nginx Web Server.201router # [361287.066388] router systemd-logind[105]: New seat seat0.202router # [361287.066541] router systemd[1]: Started User Login Management.203router # [361287.067961] router systemd[1]: Starting linger-users.service...204router # [361287.129661] router systemd[1]: linger-users.service: Deactivated successfully.205router # [361287.129900] router systemd[1]: Finished linger-users.service.206router # [361287.130372] router systemd[1]: Reached target Multi-User System.207router: still waiting for container 'router' to reach ready state...208router: still waiting for container 'router' to reach ready state...209router: still waiting for container 'router' to reach ready state...210router: still waiting for container 'router' to reach ready state...211router: still waiting for container 'router' to reach ready state...212router # [361333.901703] router systemd[1]: etc-machine\x2did.mount: Deactivated successfully.213router # [361333.902890] router systemd[1]: Finished Save Transient machine-id to Disk.214router # [361333.903099] router systemd[1]: Startup finished in 49.793s.215router: (finished: waiting for unit multi-user.target, in 50.67 seconds)216router: waiting for TCP port 80 on localhost217Connection to localhost (::1) 80 port [tcp/http] succeeded!218router: (finished: waiting for TCP port 80 on localhost, in 0.01 seconds)219machine: waiting for unit multi-user.target220machine: (finished: waiting for unit multi-user.target, in 0.02 seconds)221machine: waiting for unit nginx.service222machine: (finished: waiting for unit nginx.service, in 0.02 seconds)223router: must succeed: ip -4 addr show eth1 | grep -oP '(?<=inet\s)\d+(\.\d+){3}'224router: (finished: must succeed: ip -4 addr show eth1 | grep -oP '(?<=inet\s)\d+(\.\d+){3}', in 0.01 seconds)225router: must succeed: ip -6 addr show eth1 | grep -oP '(?<=inet6\s)[0-9a-f:]+' | grep -v '^fe80' | head -1226machine # [361333.919961] machine systemd[1]: etc-machine\x2did.mount: Deactivated successfully.227machine # [361333.921729] machine systemd[1]: Finished Save Transient machine-id to Disk.228machine # [361333.922219] machine systemd[1]: Startup finished in 49.811s.229router: (finished: must succeed: ip -6 addr show eth1 | grep -oP '(?<=inet6\s)[0-9a-f:]+' | grep -v '^fe80' | head -1, in 0.01 seconds)230Router IPv4: 192.168.1.2231Router IPv6: 2001:db8:1::2232machine: must succeed: systemctl restart nftables233machine: (finished: must succeed: systemctl restart nftables, in 0.24 seconds)234machine: waiting for unit nftables.service235machine: (finished: waiting for unit nftables.service, in 0.02 seconds)236machine: must succeed: nft list table inet user-firewall >&2237table inet user-firewall {238 chain output {239 type filter hook output priority filter; policy accept;240 oifname "lo" counter packets 0 bytes 0 accept comment "allow lo"241 oifname "tun*" counter packets 0 bytes 0 accept comment "allow tun*"242 oifname "tap*" counter packets 0 bytes 0 accept comment "allow tap*"243 oifname "wg*" counter packets 0 bytes 0 accept comment "allow wg*"244 oifname "tailscale*" counter packets 0 bytes 0 accept comment "allow tailscale*"245 oifname "zt*" counter packets 0 bytes 0 accept comment "allow zt*"246 oifname "vpn*" counter packets 0 bytes 0 accept comment "allow vpn*"247 oifname "ipsec*" counter packets 0 bytes 0 accept comment "allow ipsec*"248 oifname "nebula*" counter packets 0 bytes 0 accept comment "allow nebula*"249 oifname "tinc*" counter packets 0 bytes 0 accept comment "allow tinc*"250 oifname "edge*" counter packets 0 bytes 0 accept comment "allow edge*"251 oifname "hyprspace" counter packets 0 bytes 0 accept comment "allow hyprspace"252 oifname "ham0" counter packets 0 bytes 0 accept comment "allow ham0"253 oifname "easytier" counter packets 0 bytes 0 accept comment "allow easytier"254 oifname "mycelium" counter packets 0 bytes 0 accept comment "allow mycelium"255 meta skuid 1002 counter packets 0 bytes 0 reject comment "blocked user bob"256 }257}258machine: (finished: must succeed: nft list table inet user-firewall >&2, in 0.01 seconds)259machine: waiting for success: runuser -u alice -- curl -s http://127.0.0.1:8080260machine # [361334.409099] machine systemd[1]: Stopping nftables firewall...261machine # [361334.552466] machine systemd[1]: nftables.service: Deactivated successfully.262machine # [361334.552820] machine systemd[1]: Stopped nftables firewall.263machine # [361334.555129] machine systemd[1]: Starting nftables firewall...264machine # [361334.637065] machine systemd[1]: Finished nftables firewall.265machine: (finished: waiting for success: runuser -u alice -- curl -s http://127.0.0.1:8080, in 0.02 seconds)266machine: must succeed: runuser -u alice -- curl -s http://192.168.1.2267machine: (finished: must succeed: runuser -u alice -- curl -s http://192.168.1.2, in 0.02 seconds)268machine: must succeed: runuser -u alice -- curl -s http://[2001:db8:1::2]269machine: (finished: must succeed: runuser -u alice -- curl -s http://[2001:db8:1::2], in 0.02 seconds)270machine: must succeed: runuser -u bob -- curl -s http://127.0.0.1:8080271machine: (finished: must succeed: runuser -u bob -- curl -s http://127.0.0.1:8080, in 0.02 seconds)272machine: must succeed: runuser -u bob -- curl -s --connect-timeout 2 http://192.168.1.2 2>&1 || echo 'EXIT_CODE='$?273machine: (finished: must succeed: runuser -u bob -- curl -s --connect-timeout 2 http://192.168.1.2 2>&1 || echo 'EXIT_CODE='$?, in 0.02 seconds)274machine: must succeed: runuser -u bob -- curl -s --connect-timeout 2 http://[2001:db8:1::2] 2>&1 || echo 'EXIT_CODE='$?275machine # [361334.676281] machine runuser[238]: pam_unix(runuser:session): session opened for user alice(uid=1001) by (uid=0)276machine # [361334.687476] machine runuser[238]: pam_unix(runuser:session): session closed for user alice277machine # [361334.696933] machine runuser[240]: pam_unix(runuser:session): session opened for user alice(uid=1001) by (uid=0)278machine # [361334.706469] machine runuser[240]: pam_unix(runuser:session): session closed for user alice279machine # [361334.715371] machine runuser[242]: pam_unix(runuser:session): session opened for user alice(uid=1001) by (uid=0)280machine # [361334.724917] machine runuser[242]: pam_unix(runuser:session): session closed for user alice281machine # [361334.733063] machine runuser[244]: pam_unix(runuser:session): session opened for user bob(uid=1002) by (uid=0)282machine # [361334.741629] machine runuser[244]: pam_unix(runuser:session): session closed for user bob283machine # [361334.751357] machine runuser[247]: pam_unix(runuser:session): session opened for user bob(uid=1002) by (uid=0)284machine # [361334.761449] machine runuser[247]: pam_unix(runuser:session): session closed for user bob285machine # [361334.771213] machine runuser[250]: pam_unix(runuser:session): session opened for user bob(uid=1002) by (uid=0)286machine: (finished: must succeed: runuser -u bob -- curl -s --connect-timeout 2 http://[2001:db8:1::2] 2>&1 || echo 'EXIT_CODE='$?, in 1.05 seconds)287machine: must succeed: nft list table inet user-firewall288machine: (finished: must succeed: nft list table inet user-firewall, in 0.01 seconds)289machine: waiting for unit setup-wg0-interface.service290machine: (finished: waiting for unit setup-wg0-interface.service, in 0.02 seconds)291machine: waiting for unit nginx.service292machine: (finished: waiting for unit nginx.service, in 0.02 seconds)293machine: waiting for TCP port 8081 on 10.100.0.2294Connection to 10.100.0.2 8081 port [tcp/sunproxyadmin] succeeded!295machine: (finished: waiting for TCP port 8081 on 10.100.0.2, in 0.01 seconds)296machine: must succeed: ip link show wg0297machine: (finished: must succeed: ip link show wg0, in 0.01 seconds)298machine: must succeed: ip addr show wg0299machine: (finished: must succeed: ip addr show wg0, in 0.01 seconds)300machine: must succeed: runuser -u alice -- curl -s --interface wg0 http://10.100.0.2:8081/301machine: (finished: must succeed: runuser -u alice -- curl -s --interface wg0 http://10.100.0.2:8081/, in 0.02 seconds)302machine: must succeed: runuser -u alice -- curl -s --interface wg0 http://[fd00::2]:8081/303machine: (finished: must succeed: runuser -u alice -- curl -s --interface wg0 http://[fd00::2]:8081/, in 0.02 seconds)304machine: must succeed: runuser -u bob -- curl -s --interface wg0 http://10.100.0.2:8081/305machine: (finished: must succeed: runuser -u bob -- curl -s --interface wg0 http://10.100.0.2:8081/, in 0.02 seconds)306machine: must succeed: runuser -u bob -- curl -s --interface wg0 http://[fd00::2]:8081/307machine: (finished: must succeed: runuser -u bob -- curl -s --interface wg0 http://[fd00::2]:8081/, in 0.02 seconds)308machine: must succeed: nft list table inet user-firewall | grep -E 'oifname.*wg' >&2309 oifname "wg*" counter packets 0 bytes 0 accept comment "allow wg*"310machine: (finished: must succeed: nft list table inet user-firewall | grep -E 'oifname.*wg' >&2, in 0.01 seconds)311(finished: run the VM test script, in 52.33 seconds)312machine # [361335.810061] machine runuser[250]: pam_unix(runuser:session): session closed for user bob313machine # [361335.894913] machine runuser[258]: pam_unix(runuser:session): session opened for user alice(uid=1001) by (uid=0)314machine # [361335.904304] machine runuser[258]: pam_unix(runuser:session): session closed for user alice315machine # [361335.914273] machine runuser[260]: pam_unix(runuser:session): session opened for user alice(uid=1001) by (uid=0)316machine # [361335.924826] machine runuser[260]: pam_unix(runuser:session): session closed for user alice317machine # [361335.934825] machine runuser[262]: pam_unix(runuser:session): session opened for user bob(uid=1002) by (uid=0)318machine # [361335.944806] machine runuser[262]: pam_unix(runuser:session): session closed for user bob319machine # [361335.953909] machine runuser[264]: pam_unix(runuser:session): session opened for user bob(uid=1002) by (uid=0)320machine # [361335.964527] machine runuser[264]: pam_unix(runuser:session): session closed for user bob321test script finished in 52.73s322cleanup323kill NspawnMachine (pid 52)324kill NspawnMachine (pid 54)325Container machine terminated by signal KILL.326(finished: cleanup, in 0.33 seconds)327Container router terminated by signal KILL.