rhel 8.6 NetworkManager-ppp-1.36.0-4 cannot get PPPoE working

Latest response

uname -a
Linux film 4.18.0-372.9.1.el8.x86_64 #1 SMP Fri Apr 15 22:12:19 EDT 2022 x86_64 x86_64 x86_64 GNU/Linux

cat /etc/redhat-release
Red Hat Enterprise Linux release 8.6 (Ootpa)

rpm -qa | grep NetworkManager
NetworkManager-1.36.0-4.el8.x86_64
NetworkManager-libreswan-1.2.10-4.el8.x86_64
NetworkManager-tui-1.36.0-4.el8.x86_64
NetworkManager-ppp-1.36.0-4.el8.x86_64
NetworkManager-team-1.36.0-4.el8.x86_64
NetworkManager-libnm-1.36.0-4.el8.x86_64

rpm -qa | grep ppp
NetworkManager-ppp-1.36.0-4.el8.x86_64
ppp-2.4.7-26.el8.x86_64

nmcli con up pppoe01

journalctl -xe NM_CONNECTION=505e6856-4896-44e2-8398-e286296ac31e + NM_DEVICE=ens33
789] device (ens33): Activation: starting connection 'pppoe01' (505e6856-4896-44e2-8398-e286296ac31e)
791] device (ens33): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
794] device (ens33): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
194] device (ens33): could not take control of link 6: the device already has ifindex 2
195] device (ens33): state change: config -> failed (reason 'config-failed', sys-iface-state: 'managed')
198] device (ens33): Activation: failed for connection 'pppoe01'
201] device (ens33): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')

cat /var/log/messages
Jun 18 23:41:18 film NetworkManager[1007]: [1655566878.7764] agent-manager: agent[af70c29b93b0c287,:1.32/nmcli-connect/0]: agent registered
Jun 18 23:41:18 film NetworkManager[1007]: [1655566878.7789] device (ens33): Activation: starting connection 'pppoe01' (505e6856-4896-44e2-8398-e286296ac31e)
Jun 18 23:41:18 film NetworkManager[1007]: [1655566878.7790] audit: op="connection-activate" uuid="505e6856-4896-44e2-8398-e286296ac31e" name="pppoe01" pid=21792 uid=0 result="success"
Jun 18 23:41:18 film NetworkManager[1007]: [1655566878.7791] device (ens33): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Jun 18 23:41:18 film NetworkManager[1007]: [1655566878.7794] device (ens33): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Jun 18 23:41:18 film NetworkManager[1007]: [1655566878.7823] ppp-manager: starting PPP connection
Jun 18 23:41:18 film NetworkManager[1007]: [1655566878.7847] ppp-manager: pppd started with pid 21796
Jun 18 23:41:18 film pppd[21796]: Plugin rp-pppoe.so loaded.
Jun 18 23:41:18 film NetworkManager[21796]: Plugin rp-pppoe.so loaded.
Jun 18 23:41:18 film NetworkManager[21796]: RP-PPPoE plugin version 3.8p compiled against pppd 2.4.7
Jun 18 23:41:18 film pppd[21796]: RP-PPPoE plugin version 3.8p compiled against pppd 2.4.7
Jun 18 23:41:18 film pppd[21796]: Plugin /usr/lib64/pppd/2.4.7/nm-pppd-plugin.so loaded.
Jun 18 23:41:18 film NetworkManager[21796]: Plugin /usr/lib64/pppd/2.4.7/nm-pppd-plugin.so loaded.
Jun 18 23:41:18 film journal[21796]: nm-ppp-plugin: initializing
Jun 18 23:41:29 film pppd[21796]: pppd 2.4.7 started by root, uid 0
Jun 18 23:41:29 film journal[21796]: nm-ppp-plugin: status 3 / phase 'serial connection'
Jun 18 23:41:29 film pppd[21796]: PPP session is 4
Jun 18 23:41:29 film NetworkManager[21796]: PPP session is 4
Jun 18 23:41:29 film NetworkManager[21796]: Connected to 00:0c:29:af:12:9d via interface ens33
Jun 18 23:41:29 film pppd[21796]: Connected to 00:0c:29:af:12:9d via interface ens33
Jun 18 23:41:29 film pppd[21796]: Using interface ppp0
Jun 18 23:41:29 film journal[21796]: nm-ppp-plugin: status 5 / phase 'establish'
Jun 18 23:41:29 film NetworkManager[21796]: Using interface ppp0
Jun 18 23:41:29 film NetworkManager[21796]: Connect: ppp0 <--> ens33
Jun 18 23:41:29 film pppd[21796]: Connect: ppp0 <--> ens33
Jun 18 23:41:29 film NetworkManager[1007]: [1655566889.0088] manager: (ppp0): new Ppp device (/org/freedesktop/NetworkManager/Devices/6)
Jun 18 23:41:29 film systemd-udevd[21799]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: status 6 / phase 'authenticate'
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: passwd-hook, requesting credentials...
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: got credentials from NetworkManager
Jun 18 23:41:32 film pppd[21796]: CHAP authentication succeeded: Access granted
Jun 18 23:41:32 film NetworkManager[21796]: CHAP authentication succeeded: Access granted
Jun 18 23:41:32 film NetworkManager[21796]: CHAP authentication succeeded
Jun 18 23:41:32 film NetworkManager[21796]: peer from calling number 00:0C:29:AF:12:9D authorized
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: status 8 / phase 'network'
Jun 18 23:41:32 film pppd[21796]: CHAP authentication succeeded
Jun 18 23:41:32 film pppd[21796]: peer from calling number 00:0C:29:AF:12:9D authorized
Jun 18 23:41:32 film pppd[21796]: local IP address 10.10.10.5
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: status 9 / phase 'running'
Jun 18 23:41:32 film NetworkManager[21796]: local IP address 10.10.10.5
Jun 18 23:41:32 film NetworkManager[21796]: remote IP address 10.10.10.1
Jun 18 23:41:32 film NetworkManager[21796]: primary DNS address 8.8.8.8
Jun 18 23:41:32 film NetworkManager[21796]: secondary DNS address 8.8.4.4
Jun 18 23:41:32 film pppd[21796]: remote IP address 10.10.10.1
Jun 18 23:41:32 film NetworkManager[1007]: [1655566892.0194] device (ens33): could not take control of link 6: the device already has ifindex 2
Jun 18 23:41:32 film pppd[21796]: primary DNS address 8.8.8.8
Jun 18 23:41:32 film NetworkManager[1007]: [1655566892.0195] device (ens33): state change: config -> failed (reason 'config-failed', sys-iface-state: 'managed')
Jun 18 23:41:32 film pppd[21796]: secondary DNS address 8.8.4.4
Jun 18 23:41:32 film NetworkManager[1007]: [1655566892.0198] device (ens33): Activation: failed for connection 'pppoe01'
Jun 18 23:41:32 film NetworkManager[1007]: [1655566892.0201] device (ens33): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: ip-up event
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: sending IPv4 config to NetworkManager...
Jun 18 23:41:32 film pppd[21796]: Terminating on signal 15
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: status 10 / phase 'terminate'
Jun 18 23:41:32 film NetworkManager[21796]: Terminating on signal 15
Jun 18 23:41:32 film NetworkManager[21796]: Connect time 0.0 minutes.
Jun 18 23:41:32 film NetworkManager[21796]: Sent 0 bytes, received 0 bytes.
Jun 18 23:41:32 film pppd[21796]: Connect time 0.0 minutes.
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: status 8 / phase 'network'
Jun 18 23:41:32 film pppd[21796]: Sent 0 bytes, received 0 bytes.
Jun 18 23:41:32 film NetworkManager[1007]: [1655566892.0263] device (ppp0): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'external')
Jun 18 23:41:32 film dbus-daemon[859]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.7" (uid=0 pid=1007 comm="/usr/sbin/NetworkManager --no-daemon " label="system_u:system_r:NetworkManager_t:s0") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.33" (uid=0 pid=21796 comm="/usr/sbin/pppd nodetach lock nodefaultroute ipv6 ," label="system_u:system_r:pppd_t:s0")
Jun 18 23:41:32 film NetworkManager[1007]: [1655566892.0267] device (ppp0): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'external')
Jun 18 23:41:32 film dbus-daemon[859]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.7" (uid=0 pid=1007 comm="/usr/sbin/NetworkManager --no-daemon " label="system_u:system_r:NetworkManager_t:s0") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.33" (uid=0 pid=21796 comm="/usr/sbin/pppd nodetach lock nodefaultroute ipv6 ," label="system_u:system_r:pppd_t:s0")
Jun 18 23:41:32 film dbus-daemon[859]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.7" (uid=0 pid=1007 comm="/usr/sbin/NetworkManager --no-daemon " label="system_u:system_r:NetworkManager_t:s0") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.33" (uid=0 pid=21796 comm="/usr/sbin/pppd nodetach lock nodefaultroute ipv6 ," label="system_u:system_r:pppd_t:s0")
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: status 5 / phase 'establish'
Jun 18 23:41:32 film NetworkManager[1007]: [1655566892.0349] device (ppp0): state change: disconnected -> unmanaged (reason 'connection-assumed', sys-iface-state: 'external')
Jun 18 23:41:32 film dbus-daemon[859]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.7" (uid=0 pid=1007 comm="/usr/sbin/NetworkManager --no-daemon " label="system_u:system_r:NetworkManager_t:s0") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.33" (uid=0 pid=21796 comm="/usr/sbin/pppd nodetach lock nodefaultroute ipv6 ," label="system_u:system_r:pppd_t:s0")
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: status 11 / phase 'disconnect'
Jun 18 23:41:32 film NetworkManager[21796]: Connection terminated.
Jun 18 23:41:32 film pppd[21796]: Connection terminated.
Jun 18 23:41:32 film dbus-daemon[859]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.7" (uid=0 pid=1007 comm="/usr/sbin/NetworkManager --no-daemon " label="system_u:system_r:NetworkManager_t:s0") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.33" (uid=0 pid=21796 comm="/usr/sbin/pppd nodetach lock nodefaultroute ipv6 ," label="system_u:system_r:pppd_t:s0")
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: status 1 / phase 'dead'
Jun 18 23:41:32 film pppd[21796]: Exit.
Jun 18 23:41:32 film journal[21796]: nm-ppp-plugin: cleaning up
Jun 18 23:44:12 film NetworkManager[1007]: [1655567052.6441] dhcp4 (ens38): state changed new lease, address=192.168.171.132

NetworkManager-ppp-1.36.0-4 cannot get PPPoE working.please,help me.

Responses