Bug 1524212 - vpn pptp protocol did not working properly in new kernel release
Summary: vpn pptp protocol did not working properly in new kernel release
Keywords:
Status: CLOSED INSUFFICIENT_DATA
Alias: None
Product: Fedora
Classification: Fedora
Component: kernel
Version: 27
Hardware: x86_64
OS: Linux
unspecified
high
Target Milestone: ---
Assignee: Kernel Maintainer List
QA Contact: Fedora Extras Quality Assurance
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2017-12-10 20:27 UTC by Mohamed Okasha
Modified: 2018-08-31 01:32 UTC (History)
25 users (show)

Fixed In Version:
Doc Type: If docs needed, set a value
Doc Text:
Clone Of:
Environment:
Last Closed: 2018-03-05 15:26:47 UTC
Type: Bug
Embargoed:

Attachments (Terms of Use)

Description Mohamed Okasha 2017-12-10 20:27:15 UTC 
I have vpn network (pptp protocol), i can connected with it in fedora 25 but in fedora 27 when connected with this network i can see it giving ip address to ppp0 but without internet access and can not access remote hosts using this vpn.




4.13.16-302.fc27.x86_64:


How reproducible:

Just add new vpn (pptp) network 

Steps to Reproduce:
1.add gateway
2.add username and password
3.keep another default settings

Note:firewalld off and routing table same as routing table in fedora25 when using same settings


Actual results:
NetworkManager[870]: <info>  [1512835501.9763] audit: op="connection-activate" uuid="db4493e1-2268-4e3c-8694-1006701026cd" name="VPN 1" pid=2810 uid=1000 result="success"
Dec 09 18:05:01 localhost.localdomain NetworkManager[870]: <info>  [1512835501.9816] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",0]: Started the VPN service, PID 3855
Dec 09 18:05:01 localhost.localdomain NetworkManager[870]: <info>  [1512835501.9898] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",0]: Saw the service appear; activating connection
Dec 09 18:05:02 localhost.localdomain NetworkManager[870]: <info>  [1512835502.0755] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",0]: VPN connection: (ConnectInteractive) reply rece
Dec 09 18:05:02 localhost.localdomain NetworkManager[870]: <info>  [1512835502.0785] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",0]: VPN plugin: state changed: starting (3)
Dec 09 18:05:02 localhost.localdomain pppd[3865]: Plugin /usr/lib64/pppd/2.4.7/nm-pptp-pppd-plugin.so loaded.
Dec 09 18:05:02 localhost.localdomain NetworkManager[870]: Plugin /usr/lib64/pppd/2.4.7/nm-pptp-pppd-plugin.so loaded.
Dec 09 18:05:02 localhost.localdomain pppd[3865]: pppd 2.4.7 started by root, uid 0
Dec 09 18:05:02 localhost.localdomain pptp[3868]: nm-pptp-service-3855 log[main:pptp.c:356]: The synchronous pptp option is NOT activated
Dec 09 18:05:02 localhost.localdomain NetworkManager[870]: <info>  [1512835502.0881] manager: (ppp0): new Generic device (/org/freedesktop/NetworkManager/Devices/14)
Dec 09 18:05:02 localhost.localdomain pppd[3865]: Using interface ppp0
Dec 09 18:05:02 localhost.localdomain pppd[3865]: Connect: ppp0 <--> /dev/pts/0
Dec 09 18:05:02 localhost.localdomain NetworkManager[870]: Using interface ppp0
Dec 09 18:05:02 localhost.localdomain NetworkManager[870]: Connect: ppp0 <--> /dev/pts/0
Dec 09 18:05:02 localhost.localdomain NetworkManager[870]: Error: either "to" is duplicate, or "uid" is a garbage.
Dec 09 18:05:02 localhost.localdomain pptp[3878]: nm-pptp-service-3855 log[ctrlp_rep:pptp_ctrl.c:259]: Sent control packet type is 1 'Start-Control-Connection-Request'
Dec 09 18:05:02 localhost.localdomain pptp[3878]: nm-pptp-service-3855 log[ctrlp_disp:pptp_ctrl.c:781]: Received Start Control Connection Reply
Dec 09 18:05:02 localhost.localdomain pptp[3878]: nm-pptp-service-3855 log[ctrlp_disp:pptp_ctrl.c:815]: Client connection established.
Dec 09 18:05:03 localhost.localdomain pptp[3878]: nm-pptp-service-3855 log[ctrlp_rep:pptp_ctrl.c:259]: Sent control packet type is 7 'Outgoing-Call-Request'
Dec 09 18:05:03 localhost.localdomain pptp[3878]: nm-pptp-service-3855 log[ctrlp_disp:pptp_ctrl.c:900]: Received Outgoing Call Reply.
Dec 09 18:05:03 localhost.localdomain pptp[3878]: nm-pptp-service-3855 log[ctrlp_disp:pptp_ctrl.c:939]: Outgoing call established (call ID 44174, peer's call ID 27451).
Dec 09 18:05:03 localhost.localdomain pppd[3865]: CHAP authentication succeeded
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: CHAP authentication succeeded
Dec 09 18:05:03 localhost.localdomain pppd[3865]: local  IP address X.X.X.X
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: local  IP address X.X.X.X
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: remote IP address X.X.X.X
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: primary   DNS address X.X.X.X
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: secondary DNS address 8.8.8.8
Dec 09 18:05:03 localhost.localdomain pppd[3865]: remote IP address X.X.X.X
Dec 09 18:05:03 localhost.localdomain pppd[3865]: primary   DNS address X.X.X.X
Dec 09 18:05:03 localhost.localdomain pppd[3865]: secondary DNS address 8.8.8.8
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2504] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",0]: VPN connection: (IP4 Config Get) reply received
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2513] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: Data: VPN Gateway: X.X.X.X
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2517] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: Data: Tunnel Device: "ppp0"
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2521] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: Data: IPv4 configuration:
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2525] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: Data:   Internal Address: X.X.X.X
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2528] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: Data:   Internal Prefix: 32
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2532] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: Data:   Internal Point-to-Point Address
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2535] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: Data:   Maximum Segment Size (MSS): 0
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2538] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: Data:   Forbid Default Route: no
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2541] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: Data:   Internal DNS: X.X.X.X
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2542] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: Data:   Internal DNS: 8.8.8.8
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2542] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: Data:   DNS Domain: '(none)'
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2542] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: Data: No IPv6 configuration
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2543] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: VPN plugin: state changed: started (4)
Dec 09 18:05:03 localhost.localdomain NetworkManager[870]: <info>  [1512835503.2581] vpn-connection[0x560ad2bb44e0,db4493e1-2268-4e3c-8694-1006701026cd,"VPN 1",14:(ppp0)]: VPN connection: (IP Config Get) complet
Dec 09 18:06:14 localhost.localdomain NetworkManager[870]: <info>  [1512835574.6778] connectivity: (wlp5s0) timed out
Dec 09 18:06:57 localhost.localdomain pptp[3878]: nm-pptp-service-3855 log[logecho:pptp_ctrl.c:719]: Echo Request received.
Dec 09 18:06:57 localhost.localdomain pptp[3878]: nm-pptp-service-3855 log[ctrlp_rep:pptp_ctrl.c:259]: Sent control packet type is 6 'Echo-Reply'
Dec 09 18:07:17 localhost.localdomain pptp[3878]: nm-pptp-service-3855 log[pptp_read_some:pptp_ctrl.c:586]: read returned zero, peer has closed
Dec 09 18:07:17 localhost.localdomain pptp[3878]: nm-pptp-service-3855 log[callmgr_main:pptp_callmgr.c:269]: Closing connection (shutdown)
Dec 09 18:07:17 localhost.localdomain pppd[3865]: Modem hangup
Dec 09 18:07:17 localhost.localdomain NetworkManager[870]: Modem hangup
Dec 09 18:07:17 localhost.localdomain NetworkManager[870]: Connect time 2.3 minutes.
Dec 09 18:07:17 localhost.localdomain NetworkManager[870]: Sent 2185858213 bytes, received 0 bytes.
Dec 09 18:07:17 localhost.localdomain pppd[3865]: Connect time 2.3 minutes.
Dec 09 18:07:17 localhost.localdomain pppd[3865]: Sent 2185858213 bytes, received 0 bytes.
Dec 09 18:07:17 localhost.localdomain pppd[3865]: Connection terminated.


Additional info:
Tested with Gnome & KDE network manager
Comment 1 Mohamed Okasha 2017-12-11 11:50:45 UTC 
Dec 11 13:43:40 ME-workstation-pc pppd[12550]: Sent 2090516957 bytes, received 0 bytes.
Dec 11 13:43:40 ME-workstation-pc NetworkManager[984]: <warn>  [1512992620.1726] default-route: failed to add default route 0.0.0.0/0 via 0.0.0.0 dev 30 metric 50 mss 0 rt-src vpn with effective metric 50
Dec 11 13:43:40 ME-workstation-pc pppd[12550]: Connection terminated.
Dec 11 13:43:40 ME-workstation-pc NetworkManager[984]: Connection terminated.
Dec 11 13:43:40 ME-workstation-pc NetworkManager[984]: <warn>  [1512992620.1770] default-route: failed to add default route 0.0.0.0/0 via 0.0.0.0 dev 30 metric 50 mss 0 rt-src vpn with effective metric 50
Dec 11 13:43:40 okasha-workstation-pc NetworkManager[984]: Terminating on signal 15

Note: firewalld and SELinux desabled
Comment 2 Mohamed Okasha 2017-12-13 07:55:46 UTC 
When I downgraded kernel to 4.8.6-300.fc25 version every thing work fine
Comment 3 Laura Abbott 2018-02-20 19:48:36 UTC 
We apologize for the inconvenience.  There is a large number of bugs to go through and several of them have gone stale.  As kernel maintainers, we try to keep up with bugzilla but due the rate at which the upstream kernel project moves, bugs may be fixed without any indication to us. Due to this, we are doing a mass bug update across all of the Fedora 27 kernel bugs.
 
Fedora 27 has now been rebased to 4.15.3-300.f27.  Please test this kernel update (or newer) and let us know if you issue has been resolved or if it is still present with the newer kernel.
 
If you experience different issues, please open a new bug report for those.
Comment 4 Mohamed Okasha 2018-03-05 12:31:37 UTC 
I am sorry, i am no longer using fedora workstation in my office nor pptp protocol so i can not reproduce this error again, thank you for you response and hard work, if i'am facing similar issue again i will open new bug ticket and tag you.
Comment 5 Laura Abbott 2018-03-05 15:26:47 UTC 
Thanks for letting us know.
Comment 6 Arefin Saikat 2018-08-31 01:32:41 UTC 
I am having the same issue with Fedora 28, 4.17.12-200. When I am connected to my Office VPN I cannot access Internet but the resources in the VPN network are accessible.

Please fix this bug on your earliest convenience since this issue started from Fedora 26 and has been going on for a while.
Note You need to log in before you can comment on or make changes to this bug.