[Bug 475814] [NEW] vpnc will only connect successfully on first try per session

pat.pannuto psquared89+ubuntu at gmail.com
Thu Nov 5 20:37:39 UTC 2009


Public bug reported:

Binary package hint: vpnc

Running Karmic 9.10, 64-bit

ppannuto at orangeiguana:/var/log$ apt-cache policy vpnc
vpnc:
  Installed: 0.5.3-1
  Candidate: 0.5.3-1
  Version table:
 *** 0.5.3-1 0
        500 http://us.archive.ubuntu.com karmic/universe Packages
        100 /var/lib/dpkg/status

Vpnc will only connect successfully the first time per session.  If you
for any reason disconnect (e.g. sleeping the laptop), all vpn
connections will fail *until* you reboot the computer, in which case the
vpn connect *will succeed*.  This is reproducible.

Also note, you can connect and disconnect to "regular" (WPA2, TTLS, WEP)
at will, both before and after the one and only vpn connection /
session.  This leads me to believe the issue is with vpnc and not
wireless in general.

Relevant output from syslog:  (complete syslogs are attached)

[From First (successful) connect]:

Nov  3 15:11:57 orangeiguana NetworkManager: <info>  Starting VPN service 'org.freedesktop.NetworkManager.vpnc'...
Nov  3 15:11:57 orangeiguana NetworkManager: <info>  VPN service 'org.freedesktop.NetworkManager.vpnc' started (org.freedesktop.NetworkManager.vpnc), PID 4533
Nov  3 15:11:57 orangeiguana kernel: [14624.492405] tun: Universal TUN/TAP device driver, 1.6
Nov  3 15:11:57 orangeiguana kernel: [14624.492408] tun: (C) 1999-2004 Max Krasnyansky <maxk at qualcomm.com>
Nov  3 15:11:57 orangeiguana NetworkManager: <info>  VPN service 'org.freedesktop.NetworkManager.vpnc' just appeared, activating connections
Nov  3 15:11:57 orangeiguana NetworkManager: <info>  VPN plugin state changed: 1
Nov  3 15:11:57 orangeiguana NetworkManager: <info>  VPN plugin state changed: 3
Nov  3 15:11:57 orangeiguana NetworkManager: <info>  VPN connection 'UM On-Campus Wireless' (Connect) reply received.
Nov  3 15:11:57 orangeiguana NetworkManager:    SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/tun0, iface: tun0)
Nov  3 15:11:57 orangeiguana kernel: [14624.629071] tun0: Disabled Privacy Extensions
Nov  3 15:11:57 orangeiguana NetworkManager:    SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/tun0, iface: tun0): no ifupdown configuration found.
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  VPN connection 'UM On-Campus Wireless' (IP Config Get) reply received.
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  VPN Gateway: 141.211.255.196
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  Tunnel Device: tun0
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  Internal IP4 Address: 141.211.4.232
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  Internal IP4 Prefix: 22
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  Internal IP4 Point-to-Point Address: 141.211.4.232
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  Maximum Segment Size (MSS): 0
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  Internal IP4 DNS: 141.211.144.17
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  Internal IP4 DNS: 141.211.125.17
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  DNS Domain: 'umich.edu'
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  Login Banner:
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  -----------------------------------------
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  (null)
Nov  3 15:11:58 orangeiguana NetworkManager: <info>  -----------------------------------------
Nov  3 15:11:58 orangeiguana vpnc[4540]: can't open pidfile /var/run/vpnc/pid for writing
Nov  3 15:11:59 orangeiguana NetworkManager: <info>  (tun0): writing resolv.conf to /sbin/resolvconf
Nov  3 15:12:00 orangeiguana NetworkManager: <info>  VPN connection 'UM On-Campus Wireless' (IP Config Get) complete.
Nov  3 15:12:00 orangeiguana NetworkManager: <info>  (tun0): writing resolv.conf to /sbin/resolvconf
Nov  3 15:12:00 orangeiguana NetworkManager: <info>  Policy set 'UM On-Campus Wireless' (tun0) as default for routing and DNS.
Nov  3 15:12:00 orangeiguana NetworkManager: <info>  VPN plugin state changed: 4


[From a subsequent attempt to connect]:

Nov  5 15:13:57 orangeiguana NetworkManager: <info>  Starting VPN service 'org.freedesktop.NetworkManager.vpnc'...
Nov  5 15:13:57 orangeiguana NetworkManager: <info>  VPN service 'org.freedesktop.NetworkManager.vpnc' started (org.freedesktop.NetworkManager.vpnc), PID 15479
Nov  5 15:13:57 orangeiguana NetworkManager: <info>  VPN service 'org.freedesktop.NetworkManager.vpnc' just appeared, activating connections
Nov  5 15:13:57 orangeiguana NetworkManager: <info>  VPN plugin state changed: 1
Nov  5 15:13:57 orangeiguana ntpdate[15466]: no server suitable for synchronization found
Nov  5 15:13:57 orangeiguana ntpd[15507]: ntpd 4.2.4p6 at 1.1549-o Fri Oct 23 04:31:46 UTC 2009 (1)
Nov  5 15:13:57 orangeiguana ntpd[15508]: precision = 1.000 usec
Nov  5 15:13:57 orangeiguana ntpd[15508]: Listening on interface #0 wildcard, 0.0.0.0#123 Disabled
Nov  5 15:13:57 orangeiguana ntpd[15508]: Listening on interface #1 wildcard, ::#123 Disabled
Nov  5 15:13:57 orangeiguana ntpd[15508]: Listening on interface #2 lo, ::1#123 Enabled
Nov  5 15:13:57 orangeiguana ntpd[15508]: Listening on interface #3 wlan0, fe80::221:6bff:feab:e0f6#123 Enabled
Nov  5 15:13:57 orangeiguana ntpd[15508]: Listening on interface #4 lo, 127.0.0.1#123 Enabled
Nov  5 15:13:57 orangeiguana ntpd[15508]: Listening on interface #5 wlan0, 141.212.52.248#123 Enabled
Nov  5 15:13:57 orangeiguana ntpd[15508]: kernel time sync status 2040
Nov  5 15:13:57 orangeiguana ntpd[15508]: frequency initialized 16.488 PPM from /var/lib/ntp/ntp.drift
Nov  5 15:13:57 orangeiguana NetworkManager: <info>  VPN plugin state changed: 3
Nov  5 15:13:57 orangeiguana NetworkManager: <info>  VPN connection 'UM On-Campus Wireless' (Connect) reply received.
Nov  5 15:13:57 orangeiguana NetworkManager: <info>  VPN plugin failed: 1
Nov  5 15:13:57 orangeiguana NetworkManager: <info>  VPN plugin state changed: 6
Nov  5 15:13:57 orangeiguana NetworkManager: <info>  VPN plugin state change reason: 0
Nov  5 15:13:57 orangeiguana NetworkManager: <WARN>  connection_state_changed(): Could not process the request because no VPN connection was active.
Nov  5 15:13:57 orangeiguana NetworkManager: <info>  (wlan0): writing resolv.conf to /sbin/resolvconf
Nov  5 15:13:57 orangeiguana NetworkManager: <info>  Policy set 'Auto CAEN Wireless' (wlan0) as default for routing and DNS.
Nov  5 15:14:01 orangeiguana wpa_supplicant[1398]: CTRL-EVENT-SCAN-RESULTS 
Nov  5 15:14:02 orangeiguana wpa_supplicant[1398]: CTRL-EVENT-SCAN-RESULTS 
Nov  5 15:14:10 orangeiguana NetworkManager: <debug> [1257452050.002412] ensure_killed(): waiting for vpn service pid 15479 to exit
Nov  5 15:14:10 orangeiguana NetworkManager: <debug> [1257452050.002558] ensure_killed(): vpn service pid 15479 cleaned up
Nov  5 15:14:41 orangeiguana wpa_supplicant[1398]: CTRL-EVENT-SCAN-RESULTS 
Nov  5 15:15:01 orangeiguana CRON[15557]: (root) CMD (command -v debian-sa1 > /dev/null && debian-sa1 1 1)
Nov  5 15:15:20 orangeiguana NetworkManager: <info>  Starting VPN service 'org.freedesktop.NetworkManager.vpnc'...
Nov  5 15:15:20 orangeiguana NetworkManager: <info>  VPN service 'org.freedesktop.NetworkManager.vpnc' started (org.freedesktop.NetworkManager.vpnc), PID 15584
Nov  5 15:15:20 orangeiguana NetworkManager: <info>  VPN service 'org.freedesktop.NetworkManager.vpnc' just appeared, activating connections
Nov  5 15:15:20 orangeiguana NetworkManager: <info>  VPN plugin state changed: 1
Nov  5 15:15:20 orangeiguana NetworkManager: <info>  VPN plugin state changed: 3
Nov  5 15:15:20 orangeiguana NetworkManager: <info>  VPN connection 'UM On-Campus Wireless' (Connect) reply received.
Nov  5 15:15:20 orangeiguana NetworkManager: <info>  VPN plugin failed: 1
Nov  5 15:15:20 orangeiguana NetworkManager: <info>  VPN plugin state changed: 6
Nov  5 15:15:20 orangeiguana NetworkManager: <info>  VPN plugin state change reason: 0
Nov  5 15:15:20 orangeiguana NetworkManager: <WARN>  connection_state_changed(): Could not process the request because no VPN connection was active.
Nov  5 15:15:20 orangeiguana NetworkManager: <info>  (wlan0): writing resolv.conf to /sbin/resolvconf
Nov  5 15:15:20 orangeiguana NetworkManager: <info>  Policy set 'Auto CAEN Wireless' (wlan0) as default for routing and DNS.
Nov  5 15:15:33 orangeiguana NetworkManager: <debug> [1257452133.002443] ensure_killed(): waiting for vpn service pid 15584 to exit
Nov  5 15:15:33 orangeiguana NetworkManager: <debug> [1257452133.002631] ensure_killed(): vpn service pid 15584 cleaned up


I attempted the fix described in this bug:  https://bugs.launchpad.net/ubuntu/+source/vpnc/+bug/239570
As the symptom "The VPN login failed because the VPN program could not connect to the VPN server." was the same, but this did not help.


I am happy to help debug in any way.
Thanks!

** Affects: vpnc (Ubuntu)
     Importance: Undecided
         Status: New

-- 
vpnc will only connect successfully on first try per session
https://bugs.launchpad.net/bugs/475814
You received this bug notification because you are a member of Ubuntu
Bugs, which is subscribed to Ubuntu.

-- 
ubuntu-bugs mailing list
ubuntu-bugs at lists.ubuntu.com
https://lists.ubuntu.com/mailman/listinfo/ubuntu-bugs




More information about the universe-bugs mailing list