Bug 2039844
| Summary: | cannot bringup wireguard connection. | ||||||||
|---|---|---|---|---|---|---|---|---|---|
| Product: | Red Hat Enterprise Linux 9 | Reporter: | Sam Irlapati <irlapati> | ||||||
| Component: | NetworkManager | Assignee: | Fernando F. Mancera <ferferna> | ||||||
| Status: | CLOSED WONTFIX | QA Contact: | Desktop QE <desktop-qa-list> | ||||||
| Severity: | high | Docs Contact: | |||||||
| Priority: | low | ||||||||
| Version: | CentOS Stream | CC: | bgalvani, bstinson, ferferna, jwboyer, lrintel, ngompa13, rkhan, seth, sfaye, sukulkar, thaller, till, vbenes | ||||||
| Target Milestone: | rc | Keywords: | Triaged | ||||||
| Target Release: | --- | ||||||||
| Hardware: | x86_64 | ||||||||
| OS: | Unspecified | ||||||||
| Whiteboard: | |||||||||
| Fixed In Version: | Doc Type: | Known Issue | |||||||
| Doc Text: |
Cause: The default setting of IPv4 `rp_filter` 2(strict) will block wireguard connection when using fwmark based source routing rule.
Consequence: The wireguard connection with `wireguard.fwmark` and external IPv4 peer in NetworkManager will not work.
Workaround (if any):
By changing the `rp_filter` from 2 to 1 or 0 could resolve the problem.
Assuming the `eth1` is the interface for wireguard outgoing network flow, you may change the `rp_filter` via command:
sysctl -w net.ipv4.conf.eth1.rp_filter=1
To persistent this change, you may create `/etc/sysctl.d/99-wireguard.conf` with content of
net.ipv4.conf.eth1.rp_filter=1
Result: The wireguard connection activated as expected.
|
Story Points: | --- | ||||||
| Clone Of: | Environment: | ||||||||
| Last Closed: | 2023-07-31 09:42:53 UTC | Type: | Bug | ||||||
| Regression: | --- | Mount Type: | --- | ||||||
| Documentation: | --- | CRM: | |||||||
| Verified Versions: | Category: | --- | |||||||
| oVirt Team: | --- | RHEL 7.3 requirements from Atomic Host: | |||||||
| Cloudforms Team: | --- | Target Upstream Version: | |||||||
| Embargoed: | |||||||||
| Attachments: |
|
||||||||
Please provide a NetworkManager TRACE log when you reproduce this, see https://gitlab.freedesktop.org/NetworkManager/NetworkManager/-/blob/main/contrib/fedora/rpm/NetworkManager.conf#L27 for instructions. Thank you. NetworkManager configures your system (with IP addresses, routes, etc). When you have a networking problem, then because something is not setup right. You find out what, by looking at the system. Only in a second step look at what caused NetworkManager to create that configuration. In other words: you shared what you did and parts of NetworkManager's configuration. But that only shows what you and NetworkManager likely is going to do, but not what it actually did. Show the state in which your system is in: ``` ip link wg show ip addr ip route ip -6 route ip route show table all ip -6 route show table all ip rule ip -6 rule ping -c 1 8.8.8.8 ping -c 1 ident.me cat /etc/resolv.conf ``` Here are the series of commands I used to test if NetworkManager is working properly for wireguard.
[root@xways irlanet]# curl -4 --verbose --interface eno1 ident.me; echo ""
* Trying 49.12.234.183:80...
* Connected to ident.me (49.12.234.183) port 80 (#0)
> GET / HTTP/1.1
> Host: ident.me
> User-Agent: curl/7.76.1
> Accept: */*
>
* Mark bundle as not supporting multiuse
< HTTP/1.1 200 OK
< Server: nginx
< Date: Fri, 20 May 2022 02:00:30 GMT
< Content-Type: text/plain
< Content-Length: 13
< Access-Control-Allow-Origin: *
< Cache-Control: no-cache, no-store, must-revalidate
< X-Cache: MISS from squid-ip-isp
< X-Cache-Lookup: MISS from squid-ip-isp:3128
< X-Cache: MISS from squid-host-quiet
< X-Cache-Lookup: MISS from squid-host-quiet:3128
< Via: 1.1 squid-ip-isp (squid/5.0.6), 1.1 squid-host-quiet (squid/4.13)
< Connection: keep-alive
<
* Connection #0 to host ident.me left intact
68.117.129.13
[root@xways irlanet]# nmcli connection import type wireguard file ./test.conf
Connection 'test' (185591ee-3808-4df0-94ba-10c7fac91c05) successfully added.
[root@xways irlanet]# nmcli connection up test
Connection successfully activated (D-Bus active path: /org/freedesktop/NetworkManager/ActiveConnection/8)
[root@xways irlanet]# curl -4 --verbose --interface test ident.me; echo ""
* Trying 49.12.234.183:80...
* connect to 49.12.234.183 port 80 failed: Connection timed out
* Failed to connect to ident.me port 80: Connection timed out
* Closing connection 0
curl: (28) Failed to connect to ident.me port 80: Connection timed out
Log files follow.
This is the output of journalctl -u NetworkManager, only from the appropriate timestamp.
I realize I can't paste the entire log. Is there a way to attach files to this bug?
s NetworkManager[3260817]: <debug> [1653012048.4714] dispatcher: (29) (test) dispatching action 'pre-down' (with callback)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4716] pacrunner: call[7]: removing...
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4717] device[d85afe24774e7ddd] (test): connectivity state changed from LIMITED to NONE
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4717] device[d85afe24774e7ddd] (test): connectivity state changed from LIMITED to NONE
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4718] device[d85afe24774e7ddd] (test): remove_pending_action (1): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4718] dbus-object[eb089acb4f295539]: export: "/org/freedesktop/NetworkManager/ActiveConnection/8"
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4719] device[d85afe24774e7ddd] (test): queue activation request waiting for currently active connection to disconnect
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.4720] device (test): disconnecting for new activation request.
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4720] device[d85afe24774e7ddd] (test): state change: deactivating -> deactivating (reason 'new-activation', sys-iface-state: 'managed')
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.4720] audit: op="connection-activate" uuid="185591ee-3808-4df0-94ba-10c7fac91c05" name="test" pid=3365328 uid=0 result="success"
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4743] settings: [timestamps-keyfile]: write keyfile: "/var/lib/NetworkManager/timestamps"
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4744] dispatcher: (29) succeeded but no scripts invoked
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4744] device[d85afe24774e7ddd] (test): add_pending_action (2): 'queued-state-change-disconnected'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4744] device[d85afe24774e7ddd] (test): queue-state[disconnected, reason:new-activation, id:8032]: queue state change
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4744] device[d85afe24774e7ddd] (test): queue-state[disconnected, reason:new-activation, id:8032]: change state
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.4744] device (test): state change: deactivating -> disconnected (reason 'new-activation', sys-iface-state: 'managed')
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4744] device[d85afe24774e7ddd] (test): add_pending_action (3): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4745] device[d85afe24774e7ddd] (test): ip6: addrgenmode6: set none (already set)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4745] device[d85afe24774e7ddd] (test): ip6: addrgenmode6: toggle disable_ipv6 sysctl after disabling addr-gen-mode
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4745] platform-linux: sysctl: reading '/proc/sys/net/ipv6/conf/test/disable_ipv6': '1' (changed from '0' on last read)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4745] device[d85afe24774e7ddd] (test): deactivating device (reason 'new-activation') [60]
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4746] manager: default-route-metric: ifindex 12 released
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4746] firewalld: [2c6eb83cfc7c4464,remove:"test"]: firewall zone remove test:default
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4746] device[d85afe24774e7ddd] (test): ip:dev4: reset state
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4746] l3cfg[a1a2a8d7a15f912d,ifindex=12]: IP configuration changed (mark dirty)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4747] l3cfg[a1a2a8d7a15f912d,ifindex=12]: commit on idle (scheduled) (auto)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4747] device[d85afe24774e7ddd] (test): ip:manual4: set state none
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4747] device[d85afe24774e7ddd] (test): ip:manual6: set state none
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4747] l3cfg[a1a2a8d7a15f912d,ifindex=12]: IP configuration changed (mark dirty)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4747] device[d85afe24774e7ddd] (test): ip: set (combined) state none (was done, reason: ip-state-clear)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4747] device[d85afe24774e7ddd] (test): ip4: set state none (was done, reason: ip-state-clear)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4747] device[d85afe24774e7ddd] (test): ip:dev6: reset state
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4747] device[d85afe24774e7ddd] (test): ip6: set state none (was done, reason: ip-state-clear)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4748] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/test/use_tempaddr' to '0' (current value is identical)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4748] l3cfg[a1a2a8d7a15f912d,ifindex=12]: commit reapply
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4748] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (l3cd-changed, l3cd-old=[beedb5282b6240f6], l3cd-new=(null), commited=0)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4748] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: now zombie: [efe568680eba87ad, ip4-route, type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149], zombie[5], nm-configured, in-platform
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4749] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: now zombie: [4e736d04a1961aa3, ip4-address, 10.13.54.149/24 brd* 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 src user], zombie[5], nm-configured, in-platform
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4749] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: now zombie: [a4d0e79578ac2ffd, ip4-route, type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src user], zombie[5], nm-configured, in-platform
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4749] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (l3cd-changed, l3cd-old=[beedb5282b6240f6], l3cd-new=(null), commited=1)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4749] dns-mgr: (device_l3cd_changed): queueing DNS updates (1)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4749] dns-mgr: (device_l3cd_changed): DNS configuration changed
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4749] dns-mgr: (device_l3cd_changed): committing DNS changes (0)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4749] dns-mgr: update-dns: updating resolv.conf
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4749] dns-mgr: config: 100 best v4 2 : 192.168.13.1
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4750] dns-mgr: config: 100 best v6 2 :
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4750] dns-mgr: plugin: add domain 'irlanet.org' (i=2, p=100)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4750] dns-mgr: plugin: add domain <auto-default> (i=2, p=100)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4750] dns-mgr: plugin: settings: ifindex=2, priority=100, default-route=1, search=irlanet.org, reverse=13.168.192.in-addr.arpa
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4750] dns-sd-resolved[b0dcadbc08301a41]: clear previously configured ifindex 12
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4751] dns-sd-resolved[b0dcadbc08301a41]: send-updates: start 12 requests
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4751] dns-sd-resolved[b0dcadbc08301a41]: send-updates: SetLinkDomains ( (2, [('irlanet.org', false)]) )
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4752] dns-sd-resolved[b0dcadbc08301a41]: send-updates: SetLinkDefaultRoute ( (2, true) )
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4752] dns-sd-resolved[b0dcadbc08301a41]: send-updates: SetLinkMulticastDNS ( (2, '') )
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4752] dns-sd-resolved[b0dcadbc08301a41]: send-updates: SetLinkLLMNR ( (2, '') )
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4753] dns-sd-resolved[b0dcadbc08301a41]: send-updates: SetLinkDNS ( (2, [(2, [0xc0, 0xa8, 0x0d, 0x01])]) )
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4754] dns-sd-resolved[b0dcadbc08301a41]: send-updates: SetLinkDNSOverTLS ( (2, '') )
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4754] dns-sd-resolved[b0dcadbc08301a41]: send-updates: SetLinkDomains ( (12, []) )
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4755] dns-sd-resolved[b0dcadbc08301a41]: send-updates: SetLinkDefaultRoute ( (12, false) )
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4755] dns-sd-resolved[b0dcadbc08301a41]: send-updates: SetLinkMulticastDNS ( (12, '') )
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4756] dns-sd-resolved[b0dcadbc08301a41]: send-updates: SetLinkLLMNR ( (12, '') )
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4756] dns-sd-resolved[b0dcadbc08301a41]: send-updates: SetLinkDNS ( (12, []) )
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4756] dns-sd-resolved[b0dcadbc08301a41]: send-updates: SetLinkDNSOverTLS ( (12, '') )
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4757] dns-plugin[b0dcadbc08301a41]: [systemd-resolved] update-pending changed (pending)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4757] dns-mgr: update-pending changed: pending
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4758] dns-mgr: update-resolv-no-stub: '/run/NetworkManager/no-stub-resolv.conf' successfully written
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4782] dns-mgr: update-resolv-conf: write to /etc/resolv.conf succeeded (rc-manager=symlink)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4783] dns-mgr: update-resolv-conf: write internal file /run/NetworkManager/resolv.conf succeeded
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4783] policy: set-hostname: updating hostname (DNS configuration changed)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4783] hostname: transient hostname retrieval failed
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4783] policy: get-hostname: "xways"
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4783] hostname: transient hostname retrieval failed
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4784] policy: get-hostname: "xways"
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4784] policy: set-hostname: hostname already set to 'xways' (from system configuration)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4784] dns-mgr: current configuration: [{'nameservers': <['192.168.13.1']>, 'domains': <['irlanet.org']>, 'interface': <'eno1'>, 'priority': <100>, 'vpn': <false>}]
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4786] l3cfg[a1a2a8d7a15f912d,ifindex=12]: IP configuration changed (merged=>(null), commited=>(null))
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4786] l3cfg[a1a2a8d7a15f912d,ifindex=12]: l3cd (NULL)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4786] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (pre-commit)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4786] l3cfg[a1a2a8d7a15f912d,ifindex=12]: committing IPv4 configuration (reapply)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4787] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: zombie pruned during reapply: [efe568680eba87ad, ip4-route, type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149], zombie[4], nm-configured, in-platform
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4787] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: zombie pruned during reapply: [4e736d04a1961aa3, ip4-address, 10.13.54.149/24 brd* 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 src user], zombie[4], nm-configured, in-platform
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4787] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: zombie pruned during reapply: [a4d0e79578ac2ffd, ip4-route, type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src user], zombie[4], nm-configured, in-platform
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4787] platform: (test) address: deleting IPv4 address 10.13.54.149/24, dev test
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4792] platform-linux: event-notification: RTM_DELADDR, flags 0, seq 408: 12: 10.13.54.149/24
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4792] platform: (test) signal: address 4 removed: 10.13.54.149/24 brd 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 flags permanent,noprefixroute src kernel
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4793] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: zombie gone (untrack): [4e736d04a1961aa3, ip4-address, 10.13.54.149/24 brd* 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 src user], nm-configured, was-in-platform
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4793] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change, obj-type=ip4-address, change=removed, obj=10.13.54.149/24 brd 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 flags permanent,noprefixroute src kernel)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4793] platform-linux: event-notification: RTM_DELROUTE, flags 0, seq 0: ignore
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4793] platform-linux: event-notification: RTM_DELROUTE, flags 0, seq 0: type local table 255 10.13.54.149/32 dev 12 metric 0 mss 0 rt-src rt-kernel scope host pref-src 10.13.54.149
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4793] platform: (test) signal: route 4 removed: type local table 255 10.13.54.149/32 dev 12 metric 0 mss 0 rt-src rt-kernel scope host pref-src 10.13.54.149
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4794] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change, obj-type=ip4-route, change=removed, obj=type local table 255 10.13.54.149/32 dev 12 metric 0 mss 0 rt-src rt-kernel scope host pref-src 10.13.54.149)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4794] platform-linux: event-notification: RTM_NEWROUTE, flags multi, seq 409, in-dump: type unicast 0.0.0.0/0 via 192.168.13.1 dev 2 metric 100 mss 0 rt-src rt-dhcp scope global pref-src 192.168.13.2
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4794] platform-linux: event-notification: RTM_NEWROUTE, flags multi, seq 409, in-dump: type unicast 192.168.13.0/24 dev 2 metric 100 mss 0 rt-src rt-kernel scope link pref-src 192.168.13.2
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4795] platform-linux: event-notification: RTM_NEWROUTE, flags multi, seq 409, in-dump: type local table 255 127.0.0.0/8 dev 1 metric 0 mss 0 rt-src rt-kernel scope host pref-src 127.0.0.1
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4795] platform-linux: event-notification: RTM_NEWROUTE, flags multi, seq 409, in-dump: type local table 255 127.0.0.1/32 dev 1 metric 0 mss 0 rt-src rt-kernel scope host pref-src 127.0.0.1
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4795] platform-linux: event-notification: RTM_NEWROUTE, flags multi, seq 409: ignore
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4795] platform-linux: event-notification: RTM_NEWROUTE, flags multi, seq 409, in-dump: type local table 255 192.168.13.2/32 dev 2 metric 0 mss 0 rt-src rt-kernel scope host pref-src 192.168.13.2
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4795] platform-linux: event-notification: RTM_NEWROUTE, flags multi, seq 409: ignore
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4795] platform: (test) signal: route 4 removed: type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src rt-static scope link
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4795] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: zombie gone (untrack): [a4d0e79578ac2ffd, ip4-route, type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src user], nm-configured, was-in-platform
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4796] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change, obj-type=ip4-route, change=removed, obj=type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src rt-static scope link)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4796] platform: (test) signal: route 4 removed: type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4796] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: zombie gone (untrack): [efe568680eba87ad, ip4-route, type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149], nm-configured, was-in-platform
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4796] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change, obj-type=ip4-route, change=removed, obj=type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4796] platform-linux: do-delete-ip4-address[12: 10.13.54.149/24]: success
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4796] route-manager: sync ip4-route
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4797] l3cfg[a1a2a8d7a15f912d,ifindex=12]: committing IPv6 configuration (reapply)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4797] l3cfg[a1a2a8d7a15f912d,ifindex=12]: commit-ip6-privacy: reset initial value 0 (was 0), ifname test
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4797] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/test/use_tempaddr' to '0' (current value is identical)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4797] route-manager: sync ip6-route
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4797] l3cfg[a1a2a8d7a15f912d,ifindex=12]: acd[10.13.54.149, defending]: untrack [l3cd=0d4d5c3d1f52bc9c,obj=555194ce59424783,tag=ad0b2e2d63577cde]
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4798] l3cfg[a1a2a8d7a15f912d,ifindex=12]: acd[10.13.54.149, defending]: removed
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4798] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (post-commit)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4798] route-manager: untrack [46d2c31d8281b340] routing-rule "[4] 31756: from all lookup 254 suppress_prefixlen 0"
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4798] route-manager: untrack [46d2c31d8281b340] routing-rule "[4] 31757: not from all fwmark 0xca9d/0xffffffff lookup 51869"
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4798] route-manager: sync routing-rule
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4798] platform: routing-rule: delete [4] 31756: from all lookup 254 suppress_prefixlen 0
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4799] platform-linux: event-notification: RTM_DELRULE, flags 0, seq 410: [4] 31756: from all lookup 254 suppress_prefixlen 0
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4799] platform: signal: rt-rule removed: [4] 31756: from all lookup 254 suppress_prefixlen 0
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4799] platform-linux: do-delete-routing-rule[[4] 31756: from all lookup 254 suppress_prefixlen 0]: success
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4799] platform: routing-rule: delete [4] 31757: not from all fwmark 0xca9d/0xffffffff lookup 51869
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4799] platform-linux: event-notification: RTM_DELRULE, flags 0, seq 411: [4] 31757: not from all fwmark 0xca9d/0xffffffff lookup 51869
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4800] platform: signal: rt-rule removed: [4] 31757: not from all fwmark 0xca9d/0xffffffff lookup 51869
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4800] platform-linux: do-delete-routing-rule[[4] 31757: not from all fwmark 0xca9d/0xffffffff lookup 51869]: success
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4800] device[d85afe24774e7ddd] (test): set metered value 0
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4803] config: device-state: write #12 (/run/NetworkManager/devices/12); managed=managed, route-metric-default=0-0
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4804] active-connection[0x557f2724c2e0]: set state deactivated (was deactivating)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4804] active-connection[0x557f2724c2e0]: check-master-ready: not signalling (state deactivated, no master)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4805] dns-mgr: (update_routing_and_dns): queueing DNS updates (1)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4805] policy: set-hostname: updating hostname (routing and dns)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4805] hostname: transient hostname retrieval failed
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4806] policy: get-hostname: "xways"
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4806] hostname: transient hostname retrieval failed
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4806] policy: get-hostname: "xways"
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4806] policy: set-hostname: hostname already set to 'xways' (from system configuration)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4806] dns-mgr: (update_routing_and_dns): DNS configuration did not change
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4806] dns-mgr: (update_routing_and_dns): no DNS changes to commit (0)
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.4806] device (test): Activation: starting connection 'test' (185591ee-3808-4df0-94ba-10c7fac91c05)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4806] device[d85afe24774e7ddd] (test): activation-stage: schedule activate_stage1_device_prepare
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4807] dispatcher: (30) (test) dispatching action 'down'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4809] device[d85afe24774e7ddd] (test): remove_pending_action (2): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4810] device[d85afe24774e7ddd] (test): remove_pending_action (1): 'queued-state-change-disconnected'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4811] firewalld: [2c6eb83cfc7c4464,remove:"test"]: complete: success
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4811] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change-on-idle, obj-type-flags=0x14)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4812] dbus-object[a033a69d48a8138d]: unexport: "/org/freedesktop/NetworkManager/ActiveConnection/7"
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4813] active-connection[0x557f2724c2e0]: disposing
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4814] device[d85afe24774e7ddd] (test): activation-stage: invoke activate_stage1_device_prepare
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4814] device[d85afe24774e7ddd] (test): ip4: set state pending (was none, reason: stage1)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4814] device[d85afe24774e7ddd] (test): ip6: set state pending (was none, reason: stage1)
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.4815] device (test): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4815] device[d85afe24774e7ddd] (test): add_pending_action (2): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4816] active-connection[0x557f2724c400]: set state activating (was unknown)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4817] active-connection[0x557f2724c400]: check-master-ready: not signalling (state activating, no master)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4818] manager: default-route-metric: ifindex 12 reserves metric 50 (aspired 50)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4818] manager: ActivatingConnection now test
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4818] device[d85afe24774e7ddd] (test): remove_pending_action (1): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4819] device[d85afe24774e7ddd] (test): activation-stage: synchronously invoke activate_stage2_device_config
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.4819] device (test): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4819] device[d85afe24774e7ddd] (test): add_pending_action (2): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4820] device[d85afe24774e7ddd] (test): remove_pending_action (1): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4820] device[d85afe24774e7ddd] (test): auto-default-route is enabled for IPv4 and disabled for IPv6 (fwmark 0xca9d)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4821] route-manager: track [46d2c31d8281b340,+10] routing-rule "[4] 31756: from all lookup 254 suppress_prefixlen 0"
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4821] route-manager: track [46d2c31d8281b340,+10] routing-rule "[4] 31757: not from all fwmark 0xca9d/0xffffffff lookup 51869"
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4821] route-manager: sync routing-rule
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4821] platform: routing-rule: adding or updating: [4] 31756: from all lookup 254 suppress_prefixlen 0
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4822] platform-linux: event-notification: RTM_NEWRULE, flags 0, seq 412: [4] 31756: from all lookup 254 suppress_prefixlen 0
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4822] platform: signal: rt-rule added: [4] 31756: from all lookup 254 suppress_prefixlen 0
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4823] platform-linux: do-add-rule: success
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4823] platform: routing-rule: adding or updating: [4] 31757: not from all fwmark 0xca9d/0xffffffff lookup 51869
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4823] platform-linux: event-notification: RTM_NEWRULE, flags 0, seq 413: [4] 31757: not from all fwmark 0xca9d/0xffffffff lookup 51869
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4823] platform: signal: rt-rule added: [4] 31757: not from all fwmark 0xca9d/0xffffffff lookup 51869
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4824] platform-linux: do-add-rule: success
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4824] device[d85afe24774e7ddd] (test): bringing up device 12
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4824] platform-linux: link: change 12: flags: set 0x1/0x1 ([up] / [up])
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4824] platform-linux: do-request-link: 12
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4825] platform-linux: wireguard: fetching information for ifindex 12 (genl-id 33)...
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4825] platform-linux: event-notification: RTM_NEWLINK, flags 0, seq 415: 12: test <NOARP,UP,LOWER_UP;pointopoint,noarp,up,running,lowerup> mtu 1420 arp 65534 wireguard* not-init addrgenmode none rx:0,0 tx:2,296; wireguard public-key AiPeilbUSZed5ZOP8fAPy0MiOYXrK2T9YGe9t5PSXAc= private-key (hidden) listen-port 51820 fwmark 0xca9d
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4826] platform: (test) signal: link changed: 12: test <NOARP,UP,LOWER_UP;pointopoint,noarp,up,running,lowerup> mtu 1420 arp 65534 wireguard* init addrgenmode none driver wireguard rx:0,0 tx:2,296
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4826] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change, obj-type=link, change=changed, obj=12: test <NOARP,UP,LOWER_UP;pointopoint,noarp,up,running,lowerup> mtu 1420 arp 65534 wireguard* init addrgenmode none driver wireguard rx:0,0 tx:2,296; wireguard public-key AiPeilbUSZed5ZOP8fAPy0MiOYXrK2T9YGe9t5PSXAc= private-key (hidden) listen-port 51820 fwmark 0xca9d)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4826] device[d85afe24774e7ddd] (test): queued link change for ifindex 12
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4827] platform-linux: do-change-link[12]: success changing link: success
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4827] l3cfg[a1a2a8d7a15f912d,ifindex=12]: commit update (auto)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4827] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (pre-commit)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4827] l3cfg[a1a2a8d7a15f912d,ifindex=12]: committing IPv4 configuration (update)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4827] l3cfg[a1a2a8d7a15f912d,ifindex=12]: committing IPv6 configuration (update)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4827] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (post-commit)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4827] device[d85afe24774e7ddd] (test): wireguard link config (configure, full)...
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4828] device[d85afe24774e7ddd] (test): Activation: connection 'test' has security, but secrets are required.
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.4828] device (test): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4828] device[d85afe24774e7ddd] (test): add_pending_action (2): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4830] device[d85afe24774e7ddd] (test): remove_pending_action (1): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4832] Secrets requested for connection /org/freedesktop/NetworkManager/Settings/5 (test/wireguard)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4861] agent-manager: agent[fcf903752ef30e0b,:1.44/org.gnome.Shell.NetworkAgent/1000]: agent ignored for secrets request [0a50cc8a8ce800cc/"test"/"wireguard"] (uid 1000 not required 0)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4862] agent-manager: agent[b7b95a9565994568,:1.85021/nmcli-connect/0]: agent allowed for secrets request [0a50cc8a8ce800cc/"test"/"wireguard"]
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4862] settings-connection[832cae5c7860849e,185591ee-3808-4df0-94ba-10c7fac91c05]: (wireguard:0x557f27231700) secrets requested flags 0x5 hints 'private-key'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4863] dns-plugin[b0dcadbc08301a41]: [systemd-resolved] update-pending changed (not pending)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4863] dns-mgr: update-pending changed: not pending
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4863] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change-on-idle, obj-type-flags=0x2)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4867] agent-manager: ([0a50cc8a8ce800cc/"test"/"wireguard"]) system settings secrets sufficient
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4867] settings-connection[832cae5c7860849e,185591ee-3808-4df0-94ba-10c7fac91c05]: (wireguard:0x557f2724a1e0) existing secrets returned
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4867] settings-connection[832cae5c7860849e,185591ee-3808-4df0-94ba-10c7fac91c05]: (wireguard:0x557f2724a1e0) secrets request completed
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4869] settings-connection[832cae5c7860849e,185591ee-3808-4df0-94ba-10c7fac91c05]: (wireguard:0x557f2724a1e0) new agent secrets processed
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4869] settings: update[185591ee-3808-4df0-94ba-10c7fac91c05]: get-new-secrets: update profile "test" (not persisted)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4870] settings: storage[185591ee-3808-4df0-94ba-10c7fac91c05,183ded7bbad23a71/keyfile]: change event with connection "test" (file "/etc/NetworkManager/system-connections/test.nmconnection")
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4870] settings: update[185591ee-3808-4df0-94ba-10c7fac91c05]: updating connection "test" (183ded7bbad23a71/keyfile)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4874] manager: (test) already created virtual interface name test
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4877] device[d85afe24774e7ddd] (test): activation-stage: schedule activate_stage1_device_prepare
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4877] device[f4145163879ea9ed] (wlp1s0): add_pending_action (1): 'autoactivate'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4877] device[d85afe24774e7ddd] (test): activation-stage: invoke activate_stage1_device_prepare
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.4878] device (test): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4878] device[d85afe24774e7ddd] (test): add_pending_action (2): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4881] device[d85afe24774e7ddd] (test): remove_pending_action (1): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4881] device[d85afe24774e7ddd] (test): activation-stage: synchronously invoke activate_stage2_device_config
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.4881] device (test): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4882] device[d85afe24774e7ddd] (test): add_pending_action (2): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4884] device[d85afe24774e7ddd] (test): remove_pending_action (1): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4884] route-manager: sync routing-rule
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4885] device[d85afe24774e7ddd] (test): bringing up device 12
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4885] platform-linux: link: change 12: flags: set 0x1/0x1 ([up] / [up])
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4885] platform-linux: do-request-link: 12
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4886] platform-linux: wireguard: fetching information for ifindex 12 (genl-id 33)...
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4886] platform-linux: event-notification: RTM_NEWLINK, flags 0, seq 417: 12: test <NOARP,UP,LOWER_UP;pointopoint,noarp,up,running,lowerup> mtu 1420 arp 65534 wireguard* not-init addrgenmode none rx:0,0 tx:2,296; wireguard public-key AiPeilbUSZed5ZOP8fAPy0MiOYXrK2T9YGe9t5PSXAc= private-key (hidden) listen-port 51820 fwmark 0xca9d
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4886] platform-linux: do-change-link[12]: success changing link: success
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4886] l3cfg[a1a2a8d7a15f912d,ifindex=12]: commit update (auto)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4886] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (pre-commit)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4887] l3cfg[a1a2a8d7a15f912d,ifindex=12]: committing IPv4 configuration (update)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4887] l3cfg[a1a2a8d7a15f912d,ifindex=12]: committing IPv6 configuration (update)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4887] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (post-commit)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4887] device[d85afe24774e7ddd] (test): wireguard link config (configure, full)...
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4887] device[d85afe24774e7ddd] (test): wireguard-peer[3d5qf62h+IpbIx8mjP27lMSFjVz73XpkLK8KsCm1hHU=]: fixed endpoint "146.70.57.50:1443" (146.70.57.50:1443)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4887] platform: (test) link: change wireguard ifindex 12, wireguard private-key (hidden) listen-port 51820 fwmark 0xca9d, (replace-peers,has-private-key,has-listen-port,has-fwmark), 1 peers { { public-key 3d5qf62h+IpbIx8mjP27lMSFjVz73XpkLK8KsCm1hHU= endpoint 146.70.57.50:1443 rx 0 tx 0 keepalive 25 allowed-ips 0.0.0.0/0 (psk,ka,ep,aips,remove-aips) } }
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4932] platform-linux: wireguard: set-device, message #0 sent and confirmed
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4932] platform-linux: wireguard: fetching information for ifindex 12 (genl-id 33)...
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4935] platform: (test) signal: link changed: 12: test <NOARP,UP,LOWER_UP;pointopoint,noarp,up,running,lowerup> mtu 1420 arp 65534 wireguard* init addrgenmode none driver wireguard rx:0,0 tx:2,296
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4935] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change, obj-type=link, change=changed, obj=12: test <NOARP,UP,LOWER_UP;pointopoint,noarp,up,running,lowerup> mtu 1420 arp 65534 wireguard* init addrgenmode none driver wireguard rx:0,0 tx:2,296; wireguard public-key AiPeilbUSZed5ZOP8fAPy0MiOYXrK2T9YGe9t5PSXAc= private-key (hidden) listen-port 51820 fwmark 0xca9d)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4935] device[d85afe24774e7ddd] (test): queued link change for ifindex 12
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4935] device[d85afe24774e7ddd] (test): activation-stage: synchronously invoke activate_stage3_ip_config
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4936] firewalld: [494bfbf90e086a9d,change:"test"]: firewall zone change test:default
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4961] device[f4145163879ea9ed] (wlp1s0): remove_pending_action (0): 'autoactivate'
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.4962] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change-on-idle, obj-type-flags=0x2)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4964] dispatcher: (30) /usr/lib/NetworkManager/dispatcher.d/20-chrony-dhcp succeeded
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4964] dispatcher: (30) /usr/lib/NetworkManager/dispatcher.d/20-chrony-onoffline succeeded
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.4999] firewalld: [494bfbf90e086a9d,change:"test"]: complete: success
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5000] device[d85afe24774e7ddd] (test): activation-stage: synchronously invoke activate_stage3_ip_config
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5000] device[d85afe24774e7ddd] (test): ip4: required-timeout: disabled
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5000] device[d85afe24774e7ddd] (test): ip6: required-timeout: disabled
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5000] active-connection[0x557f2724c400]: set state-flags layer2-ready (was none)
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.5001] device (test): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5001] device[d85afe24774e7ddd] (test): add_pending_action (2): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5003] device[d85afe24774e7ddd] (test): remove_pending_action (1): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5003] device[d85afe24774e7ddd] (test): ip:manual4: set state pending
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5004] device[d85afe24774e7ddd] (test): ip:manual6: set state pending
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5004] device[d85afe24774e7ddd] (test): ipv6.route-table = 254 (policy routing not enabled)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5004] device[d85afe24774e7ddd] (test): coerce ipv4.route-table setting to "main" (table 254) as we enable auto-default-route handling
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5004] device[d85afe24774e7ddd] (test): ipv4.route-table = 254
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5004] l3cfg[a1a2a8d7a15f912d,ifindex=12]: IP configuration changed (mark dirty)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5004] l3cfg[a1a2a8d7a15f912d,ifindex=12]: commit on idle (scheduled) (auto)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5004] device[d85afe24774e7ddd] (test): ip:dev4: set state=done (has extra IP configuration)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5005] l3cfg[a1a2a8d7a15f912d,ifindex=12]: IP configuration changed (mark dirty)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5005] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/test/disable_ipv6' to '1' (current value is identical)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5005] device[d85afe24774e7ddd] (test): ip:dev6: set state=done
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5006] l3cfg[a1a2a8d7a15f912d,ifindex=12]: commit update (auto) (idle handler)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5006] l3cfg[a1a2a8d7a15f912d,ifindex=12]: acd[10.13.54.149, init]: track [l3cd=71e52fea3c91b31d,obj=a35ff9c54cc01bd7,tag=ad0b2e2d63577cde] with timeout 0 msec, defend=always (new)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5006] l3cfg[a1a2a8d7a15f912d,ifindex=12]: acd[10.13.54.149, init]: skip probing (acd disabled by configuration, during pre-check)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5006] l3cfg[a1a2a8d7a15f912d,ifindex=12]: acd[10.13.54.149, ready]: set state to ready
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5006] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (l3cd-changed, l3cd-old=(null), l3cd-new=[bb517c01f9fb46e0], commited=0)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5006] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: track: [cfff041506c630d3, ip4-address, 10.13.54.149/24 brd* 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 src user]
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5007] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: track: [11e6175a8e30d2d5, ip4-route, type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src user]
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5007] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: track: [435e980acee90b62, ip4-route, type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149]
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5007] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (l3cd-changed, l3cd-old=(null), l3cd-new=[bb517c01f9fb46e0], commited=1)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5007] dns-mgr: (device_l3cd_changed): queueing DNS updates (1)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5007] dns-mgr: (device_l3cd_changed): DNS configuration did not change
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5007] dns-mgr: (device_l3cd_changed): no DNS changes to commit (0)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5009] l3cfg[a1a2a8d7a15f912d,ifindex=12]: IP configuration changed (merged=>[bb517c01f9fb46e0], commited=>[bb517c01f9fb46e0])
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5010] l3cfg[a1a2a8d7a15f912d,ifindex=12]: l3cd (bb517c01f9fb46e0, ifindex=12)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5010] l3cfg[a1a2a8d7a15f912d,ifindex=12]: address4[0]: 10.13.54.149/24 brd* 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 src user
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5010] l3cfg[a1a2a8d7a15f912d,ifindex=12]: route4[0]: type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src user
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5010] l3cfg[a1a2a8d7a15f912d,ifindex=12]: route4[1]: type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5010] l3cfg[a1a2a8d7a15f912d,ifindex=12]: dns-priority4: 50
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5010] l3cfg[a1a2a8d7a15f912d,ifindex=12]: nameserver4[0]: 1.1.1.1
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5010] l3cfg[a1a2a8d7a15f912d,ifindex=12]: search4[0]: ~
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5010] l3cfg[a1a2a8d7a15f912d,ifindex=12]: never-default: no
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5010] l3cfg[a1a2a8d7a15f912d,ifindex=12]: ip6-privacy: disabled
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5011] l3cfg[a1a2a8d7a15f912d,ifindex=12]: dns-priority6: 50
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5011] l3cfg[a1a2a8d7a15f912d,ifindex=12]: never-default: no
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5011] l3cfg[a1a2a8d7a15f912d,ifindex=12]: proxy-browser-only: no
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5011] l3cfg[a1a2a8d7a15f912d,ifindex=12]: proxy-method: none
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5011] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (pre-commit)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5011] l3cfg[a1a2a8d7a15f912d,ifindex=12]: committing IPv4 configuration (update)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5011] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: configure-first-time: [cfff041506c630d3, ip4-address, 10.13.54.149/24 brd* 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 src user], nm-configured
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5011] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: configure-first-time: [11e6175a8e30d2d5, ip4-route, type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src user], nm-configured
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5011] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: configure-first-time: [435e980acee90b62, ip4-route, type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149], nm-configured
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5012] platform: (test) address: adding or updating IPv4 address: 10.13.54.149/24 brd 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 flags noprefixroute src unknown
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5013] platform-linux: event-notification: RTM_NEWADDR, flags 0, seq 418: 10.13.54.149/24 brd 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 flags permanent,noprefixroute src kernel
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5013] platform: (test) signal: address 4 added: 10.13.54.149/24 brd 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 flags permanent,noprefixroute src kernel
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5013] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: appeared in platform: [cfff041506c630d3, ip4-address, 10.13.54.149/24 brd* 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 src user], nm-configured, in-platform
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5013] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change, obj-type=ip4-address, change=added, obj=10.13.54.149/24 brd 10.13.54.255 lft forever pref forever lifetime 6446-0[4294967295,4294967295] dev 12 flags permanent,noprefixroute src kernel)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5014] platform-linux: event-notification: RTM_NEWROUTE, flags excl,create, seq 0: type local table 255 10.13.54.149/32 dev 12 metric 0 mss 0 rt-src rt-kernel scope host pref-src 10.13.54.149
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5014] platform: (test) signal: route 4 added: type local table 255 10.13.54.149/32 dev 12 metric 0 mss 0 rt-src rt-kernel scope host pref-src 10.13.54.149
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5014] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change, obj-type=ip4-route, change=added, obj=type local table 255 10.13.54.149/32 dev 12 metric 0 mss 0 rt-src rt-kernel scope host pref-src 10.13.54.149)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5014] platform-linux: event-notification: RTM_NEWROUTE, flags excl,create, seq 0: ignore
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5014] platform-linux: do-add-ip4-address[12: 10.13.54.149/24]: success
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5015] platform: (test) route: append IPv4 route: type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src user
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5016] platform-linux: event-notification: RTM_NEWROUTE, flags excl,create, seq 419: type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src rt-static scope link
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5016] platform: (test) signal: route 4 added: type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src rt-static scope link
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5016] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: appeared in platform: [11e6175a8e30d2d5, ip4-route, type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src user], nm-configured, in-platform
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5017] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change, obj-type=ip4-route, change=added, obj=type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src rt-static scope link)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5017] platform-linux: do-add-ip4-route[type unicast table 51869 0.0.0.0/0 dev 12 metric 50 mss 0 rt-src rt-static scope link]: success
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5017] platform: (test) route: append IPv4 route: type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5017] platform-linux: event-notification: RTM_NEWROUTE, flags excl,create, seq 420: type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5018] platform: (test) signal: route 4 added: type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5018] l3cfg[a1a2a8d7a15f912d,ifindex=12]: obj-state: appeared in platform: [435e980acee90b62, ip4-route, type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149], nm-configured, in-platform
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5018] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change, obj-type=ip4-route, change=added, obj=type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5018] platform-linux: do-add-ip4-route[type unicast 10.13.54.0/24 dev 12 metric 50 mss 0 rt-src rt-kernel scope link pref-src 10.13.54.149]: success
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5018] l3cfg[a1a2a8d7a15f912d,ifindex=12]: committing IPv6 configuration (update)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5019] l3cfg[a1a2a8d7a15f912d,ifindex=12]: commit-ip6-privacy: set value 0 (initial value was 0), ifname test
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5019] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/test/use_tempaddr' to '0' (current value is identical)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5019] l3cfg[a1a2a8d7a15f912d,ifindex=12]: acd[10.13.54.149, defending]: set state to defending
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5019] l3cfg[a1a2a8d7a15f912d,ifindex=12]: acd[10.13.54.149, defending]: start announcing failed to create probe (interface not suitable for ACD)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5020] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (acd-event, addr=10.13.54.149, state=defending)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5020] device[d85afe24774e7ddd] (test): ip:manual6: set state done
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5020] device[d85afe24774e7ddd] (test): ip:manual4: set state done
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5020] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (post-commit)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5020] device[d85afe24774e7ddd] (test): ip4: check-state: state pending => done, is_failed=0, is_pending=0, is_started=1 temp_na=0, may-fail-4=1, may-fail-6=1;; manualip4=done dev4=done; disabled6 manualip6=done dev6=done
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5020] device[d85afe24774e7ddd] (test): ip4: set state done (was pending, reason: check-ip-state)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5020] active-connection[0x557f2724c400]: set state-flags layer2-ready,ip4-ready (was layer2-ready)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5021] device[d85afe24774e7ddd] (test): ip: check-state: (combined) state none => done
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5021] device[d85afe24774e7ddd] (test): ip: set (combined) state done (was none, reason: check-ip-state)
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.5021] device (test): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5021] device[d85afe24774e7ddd] (test): add_pending_action (2): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5024] dispatcher: (31) (test) dispatching action 'pre-up' (with callback)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5027] device[d85afe24774e7ddd] (test): remove_pending_action (1): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5028] device[d85afe24774e7ddd] (test): ip6: check-state: state pending => done, is_failed=0, is_pending=0, is_started=0 temp_na=0, may-fail-4=1, may-fail-6=1;; manualip4=done dev4=done; disabled6 manualip6=done dev6=done
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5028] device[d85afe24774e7ddd] (test): ip6: set state done (was pending, reason: check-ip-state)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5028] active-connection[0x557f2724c400]: set state-flags layer2-ready,ip4-ready,ip6-ready (was layer2-ready,ip4-ready)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5028] device[d85afe24774e7ddd] (test): ip: check-state: (combined) state done => done
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5029] l3cfg[a1a2a8d7a15f912d,ifindex=12]: emit signal (platform-change-on-idle, obj-type-flags=0x14)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5029] policy: set-hostname: updating hostname (address changed)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5029] hostname: transient hostname retrieval failed
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5029] policy: get-hostname: "xways"
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5029] hostname: transient hostname retrieval failed
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5029] policy: get-hostname: "xways"
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5029] policy: set-hostname: hostname already set to 'xways' (from system configuration)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5036] dispatcher: (31) succeeded but no scripts invoked
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5036] device[d85afe24774e7ddd] (test): add_pending_action (2): 'queued-state-change-secondaries'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5036] device[d85afe24774e7ddd] (test): queue-state[secondaries, reason:none, id:8093]: queue state change
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5036] device[d85afe24774e7ddd] (test): queue-state[secondaries, reason:none, id:8093]: change state
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.5036] device (test): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5036] device[d85afe24774e7ddd] (test): add_pending_action (3): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5038] device[d85afe24774e7ddd] (test): add_pending_action (4): 'queued-state-change-activated'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5038] device[d85afe24774e7ddd] (test): queue-state[activated, reason:none, id:8094]: queue state change
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5038] device[d85afe24774e7ddd] (test): device entered SECONDARIES state
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5038] device[d85afe24774e7ddd] (test): remove_pending_action (3): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5038] device[d85afe24774e7ddd] (test): remove_pending_action (2): 'queued-state-change-secondaries'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5039] device[d85afe24774e7ddd] (test): queue-state[activated, reason:none, id:8094]: change state
May 19 21:00:48 xways NetworkManager[3260817]: <info> [1653012048.5039] device (test): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5039] device[d85afe24774e7ddd] (test): add_pending_action (3): 'in-state-change'
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5041] config: device-state: write #12 (/run/NetworkManager/devices/12); managed=managed, connection-uuid=185591ee-3808-4df0-94ba-10c7fac91c05, route-metric-default=50-50
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5041] active-connection[0x557f2724c400]: set state activated (was activating)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5042] active-connection[0x557f2724c400]: check-master-ready: not signalling (state activated, no master)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5042] device[d85afe24774e7ddd] (test): remove_pending_action (2): 'activation-8'
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5044] dns-mgr: (device_state_changed): queueing DNS updates (1)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5044] policy: set-hostname: updating hostname (routing and dns)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5044] hostname: transient hostname retrieval failed
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5044] policy: get-hostname: "xways"
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5044] hostname: transient hostname retrieval failed
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5045] policy: get-hostname: "xways"
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5045] policy: set-hostname: hostname already set to 'xways' (from system configuration)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5045] dns-mgr: (device_state_changed): DNS configuration changed
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5045] dns-mgr: (device_state_changed): committing DNS changes (0)
May 19 21:00:48 xways NetworkManager[3260817]: <debug> [1653012048.5045] dns-mgr: update-dns: updating resolv.conf
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5045] dns-mgr: config: 50 vpn v4 12 : 1.1.1.1
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5045] dns-mgr: config: 50 vpn v6 12 :
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5045] dns-mgr: config: 100 best v4 2 : 192.168.13.1
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5045] dns-mgr: config: 100 best v6 2 :
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5046] dns-mgr: plugin: add domain '~' (i=12, p=50)
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5046] dns-mgr: plugin: settings: ifindex=12, priority=50, default-route=1 (explicit), search=~, reverse=54.13.10.in-addr.arpa
May 19 21:00:48 xways NetworkManager[3260817]: <trace> [1653012048.5046] dns-mgr: plugin: add domain 'irlanet.org' (i=2, p=100)
Output from commands for NetworkManager state:
[root@xways irlanet]# ip link
1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000
link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
2: eno1: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc fq_codel state UP mode DEFAULT group default qlen 1000
link/ether 9c:8e:99:dc:ff:61 brd ff:ff:ff:ff:ff:ff
altname enp0s25
3: wlp1s0: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc mq state DOWN mode DORMANT group default qlen 1000
link/ether 4a:20:dc:89:04:75 brd ff:ff:ff:ff:ff:ff permaddr 10:0b:a9:db:96:90
12: test: <POINTOPOINT,NOARP,UP,LOWER_UP> mtu 1420 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000
link/none
[root@xways irlanet]# wg show
interface: test
public key: AiPeilbUSZed5ZOP8fAPy0MiOYXrK2T9YGe9t5PSXAc=
private key: (hidden)
listening port: 51820
fwmark: 0xca9d
peer: 3d5qf62h+IpbIx8mjP27lMSFjVz73XpkLK8KsCm1hHU=
endpoint: 146.70.57.50:1443
allowed ips: 0.0.0.0/0
transfer: 0 B received, 27.32 KiB sent
persistent keepalive: every 25 seconds
[root@xways irlanet]# ip addr
1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default qlen 1000
link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
inet 127.0.0.1/8 scope host lo
valid_lft forever preferred_lft forever
inet6 ::1/128 scope host
valid_lft forever preferred_lft forever
2: eno1: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc fq_codel state UP group default qlen 1000
link/ether 9c:8e:99:dc:ff:61 brd ff:ff:ff:ff:ff:ff
altname enp0s25
inet 192.168.13.2/24 brd 192.168.13.255 scope global dynamic noprefixroute eno1
valid_lft 7184sec preferred_lft 7184sec
inet6 fe80::9e8e:99ff:fedc:ff61/64 scope link noprefixroute
valid_lft forever preferred_lft forever
3: wlp1s0: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc mq state DOWN group default qlen 1000
link/ether 4a:20:dc:89:04:75 brd ff:ff:ff:ff:ff:ff permaddr 10:0b:a9:db:96:90
12: test: <POINTOPOINT,NOARP,UP,LOWER_UP> mtu 1420 qdisc noqueue state UNKNOWN group default qlen 1000
link/none
inet 10.13.54.149/24 brd 10.13.54.255 scope global noprefixroute test
valid_lft forever preferred_lft forever
[root@xways irlanet]# ip route
default via 192.168.13.1 dev eno1 proto dhcp src 192.168.13.2 metric 100
10.13.54.0/24 dev test proto kernel scope link src 10.13.54.149 metric 50
192.168.13.0/24 dev eno1 proto kernel scope link src 192.168.13.2 metric 100
[root@xways irlanet]# ip -6 route
::1 dev lo proto kernel metric 256 pref medium
fe80::/64 dev eno1 proto kernel metric 1024 pref medium
default via fe80::1 dev eno1 proto ra metric 100 pref low
[root@xways irlanet]# ip route show table all
default dev test table 51869 proto static scope link metric 50
default via 192.168.13.1 dev eno1 proto dhcp src 192.168.13.2 metric 100
10.13.54.0/24 dev test proto kernel scope link src 10.13.54.149 metric 50
192.168.13.0/24 dev eno1 proto kernel scope link src 192.168.13.2 metric 100
local 10.13.54.149 dev test table local proto kernel scope host src 10.13.54.149
broadcast 10.13.54.255 dev test table local proto kernel scope link src 10.13.54.149
local 127.0.0.0/8 dev lo table local proto kernel scope host src 127.0.0.1
local 127.0.0.1 dev lo table local proto kernel scope host src 127.0.0.1
broadcast 127.255.255.255 dev lo table local proto kernel scope link src 127.0.0.1
local 192.168.13.2 dev eno1 table local proto kernel scope host src 192.168.13.2
broadcast 192.168.13.255 dev eno1 table local proto kernel scope link src 192.168.13.2
::1 dev lo proto kernel metric 256 pref medium
fe80::/64 dev eno1 proto kernel metric 1024 pref medium
default via fe80::1 dev eno1 proto ra metric 100 pref low
local ::1 dev lo table local proto kernel metric 0 pref medium
local fe80::9e8e:99ff:fedc:ff61 dev eno1 table local proto kernel metric 0 pref medium
multicast ff00::/8 dev eno1 table local proto kernel metric 256 pref medium
[root@xways irlanet]# ip -6 route show table all
::1 dev lo proto kernel metric 256 pref medium
fe80::/64 dev eno1 proto kernel metric 1024 pref medium
default via fe80::1 dev eno1 proto ra metric 100 pref low
local ::1 dev lo table local proto kernel metric 0 pref medium
local fe80::9e8e:99ff:fedc:ff61 dev eno1 table local proto kernel metric 0 pref medium
multicast ff00::/8 dev eno1 table local proto kernel metric 256 pref medium
[root@xways irlanet]# ip rule
0: from all lookup local
31756: from all lookup main suppress_prefixlength 0
31757: not from all fwmark 0xca9d lookup 51869
32766: from all lookup main
32767: from all lookup default
[root@xways irlanet]# ip -6 rule
0: from all lookup local
32766: from all lookup main
[root@xways irlanet]# ping -c 1 8.8.8.8
PING 8.8.8.8 (8.8.8.8) 56(84) bytes of data.
--- 8.8.8.8 ping statistics ---
1 packets transmitted, 0 received, 100% packet loss, time 0ms
[root@xways irlanet]# ping -c 1 ident.me
PING ident.me (49.12.234.183) 56(84) bytes of data.
--- ident.me ping statistics ---
1 packets transmitted, 0 received, 100% packet loss, time 0ms
[root@xways irlanet]# cat /etc/resolv.conf
# Generated by NetworkManager
search irlanet.org
nameserver 1.1.1.1
nameserver 192.168.13.1
[root@xways irlanet]#
Created attachment 1881532 [details]
output of "journalctl"
Created attachment 1881533 [details]
output of "journalctl -u NetworkManager"
What if the issue is with the firewall or nft tables not being setup properly? Is there anyway to debug those issues? Hi Sam, Are you still having this issue ? Was it related to firewall or you need us to check the logs to find out ? Thanks, Yes, I am still having this issue. I have tried debugging this, but could not figure out what was wrong. It is beyond me. Just wanted to chime in here and say that I am also running into this issue. I’ve been bashing my head against a brick wall for hours, wondering why traffic couldn’t get through my WireGuard interface on RHEL 9. There is a problem with SELinux, but even with that set to permissive, and with the firewall, completely disabled, traffic keeps dropping through a WireGuard interface on RHEL 9. https://bugzilla.redhat.com/show_bug.cgi?id=2149452 It’s a dealbreaker, so I’m going to have to revert back to standing up a RHEL 8 server instead. Hi Seth Goldin, Sorry for the long wait. After wireguard connection up, can you try `sudo sysctl -w net.ipv4.conf.eno1.rp_filter=0`? If not, please provide content of `test.conf` (wireguard config) with private key removed. Thank you! Checked with Fedora. My best guess on root cause would be: * Fedora is defaulting `rp_filter` to `2` by `/usr/lib/sysctl.d/50-default.conf` from systemd-udev rpm, means loose. For any incoming packet targeting any of host's address, package will be accepted. * RHEL/CentOS is defaulting `rp_filter` to `1` by `/usr/lib/sysctl.d/50-redhat.conf` from redhat-release or centos-stream-release rpm, means strict, For any incoming packet not from revert route will be discard. For this use case, when package sent from WG server/endpoint to current host, the `rp_filter = 2` will discard the package as it is not from revert route be cause the revert route is via wiregard interface. Besides ask user to change `rp_filter` to 0 or 2 on out going interface, I don't have good out of box solution in NetworkManager yet. (In reply to Gris Ge from comment #17) > Hi Seth Goldin, > > Sorry for the long wait. > > After wireguard connection up, can you try `sudo sysctl -w > net.ipv4.conf.eno1.rp_filter=0`? > > If not, please provide content of `test.conf` (wireguard config) with > private key removed. > > Thank you! After changing rp_filter to 0, it works! (In reply to Sam Irlapati from comment #19) > (In reply to Gris Ge from comment #17) > > Hi Seth Goldin, > > > > Sorry for the long wait. > > > > After wireguard connection up, can you try `sudo sysctl -w > > net.ipv4.conf.eno1.rp_filter=0`? > > > > If not, please provide content of `test.conf` (wireguard config) with > > private key removed. > > > > Thank you! > > After changing rp_filter to 0, it works! Changing to rp_filter to 2, also works. Hi Sam, To fix this issue in NetworkManager, we need to change `rp_filter` of *other* interface when activating a wireguard connection. This is to risky. NetworkManager team inclined to avoid updating rp_filter because the value should be in control of users (via sysctl) and we shouldn't override system policy. Can I just generate a document guiding user to set `rp_filter` when using wireguard in RHEL 9 and close this bug as won't fix? Is there a single command that can change the default rp_filter value for all ethernet connections? (In reply to Sam Irlapati from comment #22) > Is there a single command that can change the default rp_filter value for > all ethernet connections? Hi! Yes, there is such value: `net.ipv4.conf.all.rp_filter` will configure the value for all the existing interfaces but consider that `net.ipv4.conf.default.rp_filter` will configure the value for all the *NEW* interfaces. So if you want to make sure that all the existing and future interfaces are configured with a specific value please configure both `all` and `default`. Thank you! I am closing this as WONTFIX. Fernando. |
Description of problem: Setting up of wireguard VPN does not work. I am able to import the configuration file and bring up the connection but no traffic passes through it. Version-Release number of selected component (if applicable): NetworkManager-1.36.0-0.3.el9.x86_64 How reproducible: Steps to Reproduce: 1.nmcli connection import type wireguard file test.conf 2.curl -4 --verbose ident.me 3. Actual results: [root@xways irlanet]# curl -4 ident.me; echo "" 66.188.240.22 [root@xways irlanet]# nmcli connection import type wireguard file test.conf Connection 'test' (649a8cf7-2f03-4a88-9bae-5d766dfd4528) successfully added. [root@xways irlanet]# nmcli connection up test Connection successfully activated (D-Bus active path: /org/freedesktop/NetworkManager/ActiveConnection/15) [root@xways irlanet]# curl -4 --verbose ident.me; echo "" * Trying 176.58.123.25:80... * connect to 176.58.123.25 port 80 failed: Connection timed out * Failed to connect to ident.me port 80: Connection timed out * Closing connection 0 curl: (28) Failed to connect to ident.me port 80: Connection timed out [root@xways irlanet]# nmcli connection down test Connection 'test' successfully deactivated (D-Bus active path: /org/freedesktop/NetworkManager/ActiveConnection/15) [root@xways irlanet]# curl -4 ident.me; echo "" 66.188.240.22 [root@xways irlanet]# Expected results: The following results are from a machine running fedora35 [root@salem sirlapati]# curl -4 ident.me; echo "" 66.188.240.22 [root@salem sirlapati]# nmcli connection import type wireguard file test.conf Connection 'test' (5c19f44f-c6b8-41e4-8cb6-63b730b61921) successfully added. [root@salem sirlapati]# nmcli connection up test Connection successfully activated (D-Bus active path: /org/freedesktop/NetworkManager/ActiveConnection/24) [root@salem sirlapati]# curl -4 --verbose ident.me; echo "" * Trying 176.58.123.25:80... * Connected to ident.me (176.58.123.25) port 80 (#0) > GET / HTTP/1.1 > Host: ident.me > User-Agent: curl/7.79.1 > Accept: */* > * Mark bundle as not supporting multiuse < HTTP/1.1 200 OK < Server: nginx < Date: Wed, 12 Jan 2022 14:27:17 GMT < Content-Type: text/plain; charset=utf-8 < Content-Length: 14 < Connection: keep-alive < Access-Control-Allow-Origin: * < Cache-Control: no-cache, no-store, must-revalidate < * Connection #0 to host ident.me left intact 108.62.202.211 [root@salem sirlapati]# nmcli connection down test Connection 'test' successfully deactivated (D-Bus active path: /org/freedesktop/NetworkManager/ActiveConnection/24) [root@salem sirlapati]# curl -4 ident.me; echo "" 66.188.240.22 [root@salem sirlapati]# Additional info: Same set of commands and conf files work on fedora 35 but not on centos-stream 9. I can help debug, let me know what is needed.