Hi Ritesh,
please do _not_ close this bug.
I am using an ethernet connection as primary network interface (dhcp, using
network-manager).
Establishing a PPtP VPN-Connection works as expected, except:
when I am already using a ppp connection via bluetooth /dev/rfcomm* with my PDA
(configured outside network manager) while trying to connect my VPN via PPtP:
When connecting PPtP VPN via Network Manager first (thus using ppp0) and
bluetooth PPP second (using ppp1), I can disconnect and reconnect PPtP without
problems, as long as it can use ppp0.
This corresponds with
https://bugs.launchpad.net/ubuntu/+source/network-manager-pptp/+bug/163494
which I found googling for
"nm-pppd-plugin: didn't receive an Internal IP4 Address from ppp"
I attached some syslog lines for both situations. Should I provide more
information?
Which one?
regards
Olaf
from my /var/log/syslog:
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 1 of 4 (Connection Prepare) scheduled...
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 1 of 4 (Connection Prepare) ran VPN service daemon
org.freedesktop.NetworkManager.ppp_starter (PID 12419)
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 1 of 4 (Connection Prepare) complete.
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 2 of 4 (Connection Prepare Wait) scheduled...
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN service
'org.freedesktop.NetworkManager.ppp_starter' signaled state change 1 -> 6.
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 2 of 4 (Connection Prepare Wait) waiting...
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 2 of 4 (Connection Prepare Wait) complete.
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 3 of 4 (Connect) scheduled...
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 3 of 4 (Connect) sending connect request.
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 3 of 4 (Connect) request sent, waiting for reply...
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN service
'org.freedesktop.NetworkManager.ppp_starter' signaled state change 6 -> 3.
Jan 11 21:46:14 schwarzwurzel pppd[12420]: Plugin nm-pppd-plugin.so loaded.
Jan 11 21:46:14 schwarzwurzel pppd[12420]: nm-pppd-plugin: plugin initialized.
Jan 11 21:46:14 schwarzwurzel pppd[12421]: pppd 2.4.4 started by root, uid 0
Jan 11 21:46:14 schwarzwurzel pptp[12422]: anon log[main:pptp.c:314]: The
synchronous pptp option is NOT activated
Jan 11 21:46:14 schwarzwurzel pppd[12421]: Using interface ppp1
Jan 11 21:46:14 schwarzwurzel pppd[12421]: Connect: ppp1 <--> /dev/pts/2
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 3 of 4 (Connect) reply received.
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 4 of 4 (IP Config Get) timeout scheduled...
Jan 11 21:46:14 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 3 of 4 (Connect) complete, waiting for IP
configuration...
Jan 11 21:46:15 schwarzwurzel pppd[12421]: nm-pppd-plugin: CHAP check hook.
Jan 11 21:46:17 schwarzwurzel pptp[12430]: anon log[ctrlp_rep:pptp_ctrl.c:251]:
Sent control packet type is 1 'Start-Control-Connection-Request'
Jan 11 21:46:18 schwarzwurzel pptp[12430]: anon
log[ctrlp_disp:pptp_ctrl.c:739]: Received Start Control Connection Reply
Jan 11 21:46:18 schwarzwurzel pptp[12430]: anon
log[ctrlp_disp:pptp_ctrl.c:773]: Client connection established.
Jan 11 21:46:18 schwarzwurzel pptp[12430]: anon log[ctrlp_rep:pptp_ctrl.c:251]:
Sent control packet type is 7 'Outgoing-Call-Request'
Jan 11 21:46:19 schwarzwurzel pptp[12430]: anon
log[ctrlp_disp:pptp_ctrl.c:858]: Received Outgoing Call Reply.
Jan 11 21:46:19 schwarzwurzel pptp[12430]: anon
log[ctrlp_disp:pptp_ctrl.c:897]: Outgoing call established (call ID 0, peer's
call ID 50688).
Jan 11 21:46:19 schwarzwurzel pppd[12421]: nm-pppd-plugin: CHAP credentials
requested.
Jan 11 21:46:19 schwarzwurzel pppd[12421]: CHAP authentication succeeded
Jan 11 21:46:19 schwarzwurzel pppd[12421]: MPPE 128-bit stateless compression
enabled
Jan 11 21:46:19 schwarzwurzel pppd[12421]: Cannot determine ethernet address
for proxy ARP
Jan 11 21:46:19 schwarzwurzel pppd[12421]: local IP address 217.197.85.83
Jan 11 21:46:19 schwarzwurzel pppd[12421]: remote IP address 192.109.42.188
Jan 11 21:46:19 schwarzwurzel pppd[12421]: nm-pppd-plugin: didn't receive an
Internal IP4 Address from ppp.
Jan 11 21:46:19 schwarzwurzel NetworkManager: <WARN>
nm_vpn_service_process_signal(): VPN failed for service
'org.freedesktop.NetworkManager.ppp_starter', signal 'IPConfigBad', with message 'VPN
Connection failed'.
Jan 11 21:46:19 schwarzwurzel NetworkManager: <info> VPN service
'org.freedesktop.NetworkManager.ppp_starter' signaled state change 3 -> 5.
Jan 11 21:46:19 schwarzwurzel NetworkManager: <info> VPN service
'org.freedesktop.NetworkManager.ppp_starter' signaled state change 5 -> 6.
Jan 11 21:46:19 schwarzwurzel NetworkManager: <WARN>
nm_vpn_service_stop_connection(): (VPN Service
org.freedesktop.NetworkManager.ppp_starter): could not stop connection 'IN-VPN PPtP
IN-only ausser lama' because service was 6.
Jan 11 21:46:19 schwarzwurzel pptp[12430]: anon
log[callmgr_main:pptp_callmgr.c:258]: Closing connection (shutdown)
Jan 11 21:46:19 schwarzwurzel pptp[12430]: anon log[ctrlp_rep:pptp_ctrl.c:251]:
Sent control packet type is 12 'Call-Clear-Request'
Jan 11 21:46:19 schwarzwurzel pptp[12430]: anon
log[call_callback:pptp_callmgr.c:79]: Closing connection (call state)
Jan 11 21:46:19 schwarzwurzel pppd[12421]: Terminating on signal 15
Jan 11 21:46:19 schwarzwurzel pppd[12421]: Modem hangup
Jan 11 21:46:19 schwarzwurzel pppd[12421]: Connect time 0.0 minutes.
Jan 11 21:46:19 schwarzwurzel pppd[12421]: Sent 0 bytes, received 0 bytes.
Jan 11 21:46:19 schwarzwurzel pppd[12421]: MPPE disabled
Jan 11 21:46:19 schwarzwurzel pppd[12421]: Connection terminated.
Jan 11 21:46:19 schwarzwurzel pppd[12421]: Exit.
After removing my bluetooth dongle and thus freeing ppp0 everything works as
expected, and I can even reconnect leaving the re-established bluetooth
connection with ppp1 intact:
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 1 of 4 (Connection Prepare) scheduled...
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 1 of 4 (Connection Prepare) ran VPN service daemon
org.freedesktop.NetworkManager.ppp_starter (PID 12632)
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 1 of 4 (Connection Prepare) complete.
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 2 of 4 (Connection Prepare Wait) scheduled...
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN service
'org.freedesktop.NetworkManager.ppp_starter' signaled state change 1 -> 6.
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 2 of 4 (Connection Prepare Wait) waiting...
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 2 of 4 (Connection Prepare Wait) complete.
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 3 of 4 (Connect) scheduled...
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 3 of 4 (Connect) sending connect request.
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 3 of 4 (Connect) request sent, waiting for reply...
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN service
'org.freedesktop.NetworkManager.ppp_starter' signaled state change 6 -> 3.
Jan 11 21:50:06 schwarzwurzel pppd[12633]: Plugin nm-pppd-plugin.so loaded.
Jan 11 21:50:06 schwarzwurzel pppd[12633]: nm-pppd-plugin: plugin initialized.
Jan 11 21:50:06 schwarzwurzel pppd[12634]: pppd 2.4.4 started by root, uid 0
Jan 11 21:50:06 schwarzwurzel pptp[12635]: anon log[main:pptp.c:314]: The
synchronous pptp option is NOT activated
Jan 11 21:50:06 schwarzwurzel pppd[12634]: Using interface ppp0
Jan 11 21:50:06 schwarzwurzel pppd[12634]: Connect: ppp0 <--> /dev/pts/2
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 3 of 4 (Connect) reply received.
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 4 of 4 (IP Config Get) timeout scheduled...
Jan 11 21:50:06 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 3 of 4 (Connect) complete, waiting for IP
configuration...
Jan 11 21:50:07 schwarzwurzel pppd[12634]: nm-pppd-plugin: CHAP check hook.
Jan 11 21:50:09 schwarzwurzel pptp[12643]: anon log[ctrlp_rep:pptp_ctrl.c:251]:
Sent control packet type is 1 'Start-Control-Connection-Request'
Jan 11 21:50:09 schwarzwurzel pptp[12643]: anon
log[ctrlp_disp:pptp_ctrl.c:739]: Received Start Control Connection Reply
Jan 11 21:50:09 schwarzwurzel pptp[12643]: anon
log[ctrlp_disp:pptp_ctrl.c:773]: Client connection established.
Jan 11 21:50:10 schwarzwurzel pptp[12643]: anon log[ctrlp_rep:pptp_ctrl.c:251]:
Sent control packet type is 7 'Outgoing-Call-Request'
Jan 11 21:50:10 schwarzwurzel pptp[12643]: anon
log[ctrlp_disp:pptp_ctrl.c:858]: Received Outgoing Call Reply.
Jan 11 21:50:10 schwarzwurzel pptp[12643]: anon
log[ctrlp_disp:pptp_ctrl.c:897]: Outgoing call established (call ID 0, peer's
call ID 50944).
Jan 11 21:50:10 schwarzwurzel pppd[12634]: nm-pppd-plugin: CHAP credentials
requested.
Jan 11 21:50:10 schwarzwurzel pppd[12634]: CHAP authentication succeeded
Jan 11 21:50:10 schwarzwurzel pppd[12634]: MPPE 128-bit stateless compression
enabled
Jan 11 21:50:10 schwarzwurzel pppd[12634]: Cannot determine ethernet address
for proxy ARP
Jan 11 21:50:10 schwarzwurzel pppd[12634]: local IP address 217.197.85.83
Jan 11 21:50:10 schwarzwurzel pppd[12634]: remote IP address 192.109.42.188
Jan 11 21:50:10 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 4 of 4 (IP Config Get) reply received.
Jan 11 21:50:11 schwarzwurzel NetworkManager: <info> DHCP returned name
servers but system has disabled dynamic modification!
Jan 11 21:50:11 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) Stage 4 of 4 (IP Config Get) complete.
Jan 11 21:50:11 schwarzwurzel NetworkManager: <info> VPN Activation (IN-VPN
PPtP IN-only ausser lama) successful.
Jan 11 21:50:11 schwarzwurzel NetworkManager: <info> VPN service
'org.freedesktop.NetworkManager.ppp_starter' signaled state change 3 -> 4.
Jan 11 21:50:11 schwarzwurzel NetworkManager: <debug> [1231707011.956240]
nm_dbus_signal_filter(): NetworkManagerInfo triggered update of VPN connection
'IN-VPN PPtP IN-only ausser lama'
--
To UNSUBSCRIBE, email to debian-bugs-dist-requ...@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmas...@lists.debian.org
