[Bug 1556357] Re: WiFi fails to resume after suspend; Race with wpasupplicant / wpa_cli resume?

[Martin Pitt]

Which Ubuntu release is that, wily or xenial? (Please use apport to file
bugs).

/lib/systemd/system-sleep/wpasupplicant is a nasty hack/workaround
introduced in bug 1422143; this is mirroring what we did before
in/usr/lib/pm-utils/sleep.d/60_wpa_supplicant, but this really needs to
be fixed properly in NM or wpa (not sure which) at some point..

** No longer affects: systemd (Ubuntu)

** Also affects: network-manager (Ubuntu)
   Importance: Undecided
       Status: New

-- 
You received this bug notification because you are a member of Ubuntu
Foundations Bugs, which is subscribed to systemd in Ubuntu.
https://bugs.launchpad.net/bugs/1556357

Title:
  WiFi fails to resume after suspend; Race with wpasupplicant / wpa_cli
  resume?

Status in network-manager package in Ubuntu:
  New
Status in wpasupplicant package in Ubuntu:
  New

Bug description:
  Hi,

  I'm constantly having issues where my WiFi connection doesn't re-
  establish after resuming from suspend. I think it may be a race where
  the interface isn't ready yet and systemd-sleep calls /lib/systemd
  /system-sleep/wpasupplicant (which is a wrapper to wpa_cli).

  I normally restart NetworkManager but then found that calling 'wpa_cli
  resume' works also.

  Here's the logs:

  | Mar 12 13:53:06 ragnar.local kernel: psmouse serio1: synaptics: quirked min/max coordinates: x [1024..5112], y [2024..4832]
  | Mar 12 13:53:06 ragnar.local kernel: PM: resume of devices complete after 562.709 msecs
  | Mar 12 13:53:06 ragnar.local kernel: PM: Finishing wakeup.
  | Mar 12 13:53:06 ragnar.local systemd[1]: Time has been changed
  | Mar 12 13:53:06 ragnar.local systemd[1066]: Time has been changed
  | Mar 12 13:53:06 ragnar.local kernel: Restarting tasks ... done.
  | Mar 12 13:53:06 ragnar.local systemd-sleep[29174]: System resumed.
  | Mar 12 13:53:06 ragnar.local systemd-sleep[29174]: Failed to connect to non-global ctrl_ifname: (nil)  error: No such file or directory
  | Mar 12 13:53:06 ragnar.local systemd-sleep[29227]: /lib/systemd/system-sleep/wpasupplicant failed with error code 255.
  | Mar 12 13:53:06 ragnar.local systemd[1]: Started Suspend.
  | Mar 12 13:53:06 ragnar.local systemd[1]: sleep.target: Unit not needed anymore. Stopping.
  | Mar 12 13:53:06 ragnar.local systemd[1]: Stopped target Sleep.
  | Mar 12 13:53:06 ragnar.local systemd[1]: Reached target Suspend.
  | Mar 12 13:53:06 ragnar.local systemd[1]: suspend.target: Unit is bound to inactive unit systemd-suspend.service. Stopping, too.
  | Mar 12 13:53:06 ragnar.local NetworkManager[23292]: <info>  wake requested (sleeping: yes  enabled: yes)
  | Mar 12 13:53:06 ragnar.local systemd[1]: Stopped target Suspend.
  | Mar 12 13:53:06 ragnar.local NetworkManager[23292]: <info>  waking up...
  | Mar 12 13:53:06 ragnar.local systemd-logind[662]: Operation 'sleep' finished.
  | Mar 12 13:53:06 ragnar.local kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
  | Mar 12 13:53:06 ragnar.local kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
  | Mar 12 13:53:06 ragnar.local NetworkManager[23292]: <info>  (wlp3s0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
  | Mar 12 13:53:06 ragnar.local kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
  | Mar 12 13:53:07 ragnar.local kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
  | Mar 12 13:53:07 ragnar.local kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Enabled
  | Mar 12 13:53:07 ragnar.local NetworkManager[23292]: <info>  NetworkManager state is now DISCONNECTED
  | Mar 12 13:53:07 ragnar.local kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
  | Mar 12 13:53:07 ragnar.local wpa_supplicant[23157]: dbus: wpa_dbus_get_object_properties: failed to get object properties: (none) none
  | Mar 12 13:53:07 ragnar.local wpa_supplicant[23157]: dbus: Failed to construct signal
  | Mar 12 13:53:07 ragnar.local wpa_supplicant[23157]: Could not read interface p2p-dev-wlp3s0 flags: No such device
  | Mar 12 13:53:07 ragnar.local NetworkManager[23292]: <info>  (wlp3s0): supplicant interface state: starting -> ready
  | Mar 12 13:53:07 ragnar.local NetworkManager[23292]: <info>  (wlp3s0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
  | Mar 12 13:53:07 ragnar.local NetworkManager[23292]: <info>  Device 'wlp3s0' has no connection; scheduling activate_check in 0 seconds.
  | Mar 12 13:53:07 ragnar.local kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready


  Thanks,

  Haw

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/network-manager/+bug/1556357/+subscriptions