FS#61699 - [networkmanager]Regression: Networkmanager crashes when using VPN via PPTP or SSTP after upgrade

Attached to Project: Arch Linux
Opened by PCMan (pcman) - Sunday, 10 February 2019, 10:30 GMT
Last edited by Toolybird (Toolybird) - Monday, 29 May 2023, 03:39 GMT
Task Type Bug Report
Category Packages: Extra
Status Closed
Assigned To Jan Alexander Steffens (heftig)
Architecture x86_64
Severity Medium
Priority Normal
Reported Version
Due in Version Undecided
Due Date Undecided
Percent Complete 100%
Votes 1
Private No

Details

Description:
I used extra/networkmanager-pptp to connect to a VPN service without problems in the past but it stopped working after upgrading archlinux.

Additional info:
* package version(s):
- extra/networkmanager 1.14.5dev+17+gba83251bb-2 (gnome)
- extra/networkmanager-pptp 1.2.9dev+10+gb41b0d0-1
- extra/libnm 1.14.5dev+17+gba83251bb-2

* config and/or log files etc.
error log from journalctl:

2月 10 18:26:34 arch-pc NetworkManager[8942]: <info> [1549794394.4585] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",0]: Started the VPN service, PID 8990
2月 10 18:26:34 arch-pc NetworkManager[8942]: <info> [1549794394.4680] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",0]: Saw the service appear; activating connection
2月 10 18:26:34 arch-pc NetworkManager[8942]: <info> [1549794394.4727] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",0]: VPN connection: (ConnectInteractive) reply received
2月 10 18:26:34 arch-pc NetworkManager[8942]: <info> [1549794394.4769] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",0]: VPN plugin: state changed: starting (3)
2月 10 18:26:34 arch-pc pppd[8994]: Plugin /usr/lib/pppd/2.4.7/nm-pptp-pppd-plugin.so loaded.
2月 10 18:26:34 arch-pc NetworkManager[8942]: Plugin /usr/lib/pppd/2.4.7/nm-pptp-pppd-plugin.so loaded.
2月 10 18:26:34 arch-pc pppd[8994]: pppd 2.4.7 started by root, uid 0
2月 10 18:26:34 arch-pc pppd[8994]: Using interface ppp0
2月 10 18:26:34 arch-pc NetworkManager[8942]: Using interface ppp0
2月 10 18:26:34 arch-pc NetworkManager[8942]: Connect: ppp0 <--> /dev/pts/3
2月 10 18:26:34 arch-pc pppd[8994]: Connect: ppp0 <--> /dev/pts/3
2月 10 18:26:34 arch-pc NetworkManager[8942]: <info> [1549794394.4860] manager: (ppp0): new Ppp device (/org/freedesktop/NetworkManager/Devices/6)
2月 10 18:26:34 arch-pc pptp[8997]: nm-pptp-service-8990 log[main:pptp.c:353]: The synchronous pptp option is NOT activated
2月 10 18:26:34 arch-pc pptp[9007]: nm-pptp-service-8990 log[ctrlp_rep:pptp_ctrl.c:259]: Sent control packet type is 1 'Start-Control-Connection-Request'
2月 10 18:26:34 arch-pc pptp[9007]: nm-pptp-service-8990 log[ctrlp_disp:pptp_ctrl.c:781]: Received Start Control Connection Reply
2月 10 18:26:34 arch-pc pptp[9007]: nm-pptp-service-8990 log[ctrlp_disp:pptp_ctrl.c:815]: Client connection established.
2月 10 18:26:35 arch-pc pptp[9007]: nm-pptp-service-8990 log[ctrlp_rep:pptp_ctrl.c:259]: Sent control packet type is 7 'Outgoing-Call-Request'
2月 10 18:26:35 arch-pc pptp[9007]: nm-pptp-service-8990 log[ctrlp_disp:pptp_ctrl.c:900]: Received Outgoing Call Reply.
2月 10 18:26:35 arch-pc pptp[9007]: nm-pptp-service-8990 log[ctrlp_disp:pptp_ctrl.c:939]: Outgoing call established (call ID 56452, peer's call ID 542).
2月 10 18:26:35 arch-pc pppd[8994]: CHAP authentication succeeded
2月 10 18:26:35 arch-pc NetworkManager[8942]: CHAP authentication succeeded
2月 10 18:26:35 arch-pc pppd[8994]: CCP terminated by peer (No compression negotiated)
2月 10 18:26:35 arch-pc NetworkManager[8942]: CCP terminated by peer (No compression negotiated)
2月 10 18:26:35 arch-pc NetworkManager[8942]: Compression disabled by peer.
2月 10 18:26:35 arch-pc pppd[8994]: Compression disabled by peer.
2月 10 18:26:35 arch-pc pppd[8994]: Cannot determine ethernet address for proxy ARP
2月 10 18:26:35 arch-pc NetworkManager[8942]: Cannot determine ethernet address for proxy ARP
2月 10 18:26:35 arch-pc NetworkManager[8942]: local IP address 192.168.87.179
2月 10 18:26:35 arch-pc NetworkManager[8942]: remote IP address 192.168.87.254
2月 10 18:26:35 arch-pc NetworkManager[8942]: primary DNS address 192.168.87.254
2月 10 18:26:35 arch-pc pppd[8994]: local IP address 192.168.87.179
2月 10 18:26:35 arch-pc pppd[8994]: remote IP address 192.168.87.254
2月 10 18:26:35 arch-pc pppd[8994]: primary DNS address 192.168.87.254
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.5978] device (ppp0): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'external')
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.5997] device (ppp0): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'external')
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6011] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",0]: VPN connection: (IP4 Config Get) reply received from old-style plugin
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6021] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: Data: VPN Gateway: 61.216.8.103
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6022] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: Data: Tunnel Device: "ppp0"
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6022] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: Data: IPv4 configuration:
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6022] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: Data: Internal Address: 192.168.87.179
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6023] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: Data: Internal Prefix: 32
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6023] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: Data: Internal Point-to-Point Address: 192.168.87.254
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6023] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: Data: Static Route: 0.0.0.0/0 Next Hop: 0.0.0.0
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6024] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: Data: Static Route: 192.168.87.254/32 Next Hop: 0.0.0.0
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6024] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: Data: Internal DNS: 192.168.87.254
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6024] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: Data: DNS Domain: '(none)'
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6025] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: Data: No IPv6 configuration
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6025] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: VPN plugin: state changed: started (4)
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6026] policy: auto-activating connection 'Hinet ADSL' (d674e560-39ea-4f7c-be6a-badec6042b6a)
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6048] vpn-connection[0x55a7d53800f0,c0880926-1cab-44e8-8f26-becca3000d60,"Appier PPTP",16:(ppp0)]: VPN connection: (IP Config Get) complete
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6051] device (ppp0): Activation: starting connection 'Hinet ADSL' (d674e560-39ea-4f7c-be6a-badec6042b6a)
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6392] policy: set 'Appier PPTP' (ppp0) as default for IPv4 routing and DNS
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6778] device (ppp0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6786] device (ppp0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
2月 10 18:26:35 arch-pc NetworkManager[8942]: <info> [1549794395.6797] loaded PPP plugin /usr/lib/NetworkManager/1.14.5dev+17+gba83251bb-2/libnm-ppp-plugin.so
2月 10 18:26:35 arch-pc NetworkManager[8942]: ((../NetworkManager/src/ppp/nm-ppp-manager.c:1346)): assertion '<dropped>' failed
2月 10 18:26:35 arch-pc NetworkManager[8942]: ((../NetworkManager/src/ppp/nm-ppp-manager-call.c:94)): assertion '<dropped>' failed
2月 10 18:26:36 arch-pc systemd[1]: NetworkManager.service: Main process exited, code=dumped, status=11/SEGV


Steps to reproduce:
1. Setup a VPN connection with network manager connection editor and choose PPTP and name it "Test VPN"
2. Connect to it using command: nmcli con up 'Test VPN'
Then you will see the message:
"Connection successfully activated (D-Bus active path: /org/freedesktop/NetworkManager/ActiveConnection/5)"
4. Type: nmcli con show
Then you can see the VPN is NOT connected.
5. Check error log: journal -x -u NetworkManager, you can see network manager crashes with core dump, and restarted
   nm_error_log.txt (17.9 KiB)
This task depends upon

Closed by  Toolybird (Toolybird)
Monday, 29 May 2023, 03:39 GMT
Reason for closing:  No response
Additional comments about closing:  Plus it's old and stale. If still an issue, please report upstream.
Comment by PCMan (pcman) - Sunday, 10 February 2019, 10:32 GMT
Please let me know if you still need other info. I can try to obtain them. Thank you.
Comment by PCMan (pcman) - Sunday, 10 February 2019, 10:34 GMT
This stopped working roughly at the end of 2018. Not sure after which upgrade this became unusable.

BTW, if I use pptp-client directly (without network manager) to connect to the VPN, it works.
So I guess it's more like a bug in NetworkManager.
Comment by PCMan (pcman) - Sunday, 10 February 2019, 10:35 GMT
I also tried the unofficial networkmanager-sstp plugin, but networkmanager also crashed when connecting to the VPN.
Comment by PCMan (pcman) - Sunday, 10 February 2019, 10:38 GMT
The last 3 lines of the error log are the most informative:

2月 10 18:26:35 arch-pc NetworkManager[8942]: ((../NetworkManager/src/ppp/nm-ppp-manager.c:1346)): assertion '<dropped>' failed
2月 10 18:26:35 arch-pc NetworkManager[8942]: ((../NetworkManager/src/ppp/nm-ppp-manager-call.c:94)): assertion '<dropped>' failed
2月 10 18:26:36 arch-pc systemd[1]: NetworkManager.service: Main process exited, code=dumped, status=11/SEGV
Comment by mattia (nTia89) - Saturday, 19 March 2022, 11:09 GMT
This is a very old issue. Is it still valid for you with latest version?

Loading...