Timeout error adding wireless interface to supplicant with NM 1.14.4



 

Hi all,

 

I have an issue with the latest stable NetworkManager version 1.14.4 related with the wireless interface. In the initialization process, NM turns up the wireless interface (wlan0) and starts the wpa_supplicant but always fails adding the interface to the supplicant manager with the same timeout error:

 

                <error> [1549972898.4209] sup-iface[0xaaaaf15ab0d0,wlan0]: error adding interface: Timeout was reached

 

After this error NM starts a retry system (5 times more) but never connects with the supplicant to start using the wlan0 interface:

 

<debug> [1549972871.9456] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/disable_ipv6' to '1' (current value is '0')

<debug> [1549972871.9458] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/disable_ipv6' to '0' (current value is '1')

<debug> [1549972871.9459] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_defrtr' to '0' (current value is '1')

<debug> [1549972872.2899] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_pinfo' to '0' (current value is '1')

<debug> [1549972872.2901] platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/wlan0/accept_ra_rtr_pref': (2) No such file or directory

<debug> [1549972872.2903] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/use_tempaddr' to '0' (current value is identical)

<debug> [1549972872.2905] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/forwarding' to '0' (current value is identical)

<debug> [1549972872.2907] device[0xaaaaf163c990] (wlan0): bringing up device 6

<debug> [1549972872.2908] platform: link: setting up "wlan0" (6)

<debug> [1549972872.2909] platform-linux: link: change 6: flags: set 0x1/0x1 ([up] / [up])

<debug> [1549972872.2912] platform-linux: do-request-link: 6

<debug> [1549972872.2915] platform: signal: link changed: 6: wlan0 <UP;broadcast,multicast,up> mtu 1500 arp 1 wifi? init addrgenmode none addr 00:04:8D:01:32:02 driver hif_pci rx:0,0 tx:0,0

<debug> [1549972872.2918] platform-linux: do-change-link[6]: success changing link: success

<debug> [1549972872.2919] device[0xaaaaf163c990] (wlan0): preparing device

<debug> [1549972872.2920] device[0xaaaaf163c990] (wlan0): clearing queued IP4 config change

<debug> [1549972872.2921] device[0xaaaaf163c990] (wlan0): clearing queued IP6 config change

<debug> [1549972872.2929] device[0xaaaaf163c990] (wlan0): ip4-config: update (commit=1, new-config=(nil))

<debug> [1549972872.2930] device[0xaaaaf163c990] (wlan0): ip4-config: clear IP Config instance (/org/freedesktop/NetworkManager/IP4Config/1)

<debug> [1549972872.2948] device[0xaaaaf163c990] (wlan0): ip6-config: update (commit=1, new-config=(nil))

<debug> [1549972872.2949] device[0xaaaaf163c990] (wlan0): ip6-config: clear IP Config instance (/org/freedesktop/NetworkManager/IP6Config/1)

        <debug> [1549972872.2982] supplicant: (wlan0): creating new supplicant interface

<debug> [1549972872.2988] device[0xaaaaf163c990] (wlan0): add_pending_action (1): 'waiting-for-supplicant'

<debug> [1549972872.2990] device[0xaaaaf163c990] (wlan0): device not yet available for transition to DISCONNECTED

<debug> [1549972872.3020] device[0xaaaaf163c990] (wlan0): connectivity state changed from UNKNOWN to NONE

<debug> [1549972872.3022] manager: connectivity checking indicates NONE

<debug> [1549972872.3028] dispatcher: (2) dispatching action 'connectivity-change'

        […]

<debug> [1549972873.3918] firewall: firewall initialized (not running)

<debug> [1549972873.3928] manager: (lo): assume: don't assume because not managed

<debug> [1549972873.3931] manager: (can0): assume: don't assume because not managed

<debug> [1549972873.3933] manager: (can1): assume: don't assume because not managed

<debug> [1549972873.3934] manager: (eth0): assume: don't assume because not managed

<debug> [1549972873.3935] manager: (eth1): assume: don't assume because not managed

<debug> [1549972873.3937] manager: check_if_startup_complete returns FALSE because of wlan0

<info>  [1549972873.3949] bluez: use BlueZ version 5

<info>  [1549972873.3977] supplicant: wpa_supplicant running

<debug> [1549972873.3980] supplicant: AP mode is supported

<debug> [1549972873.3981] supplicant: PMF is not supported

<debug> [1549972873.3982] supplicant: FILS is not supported

<debug> [1549972873.3984] supplicant: EAP-FAST is supported

<debug> [1549972873.3985] sup-iface[0xaaaaf15ab0d0,wlan0]: adding interface to supplicant

<info>  [1549972873.3987] device (wlan0): supplicant interface state: init -> starting

<info>  [1549972873.4041] bluez5: NAP: added interface 00:04:8D:01:32:03

ModemManager[2237]: <info>  ModemManager (version 1.8.2) starting in system bus...

 

<info>  [1549972873.5724] modem-manager: ModemManager not available

<info>  [1549972873.6141] modem-manager: ModemManager now available

        <error> [1549972898.4209] sup-iface[0xaaaaf15ab0d0,wlan0]: error adding interface: Timeout was reached

<info>  [1549972898.4212] device (wlan0): supplicant interface state: starting -> down

<debug> [1549972898.4214] device[0xaaaaf163c990] (wlan0): add_pending_action (2): 'recheck-available'

<debug> [1549972898.4215] device[0xaaaaf163c990] (wlan0): remove_pending_action (1): 'waiting-for-supplicant'

<debug> [1549972898.4216] device[0xaaaaf163c990] (wlan0): wifi-scan: reset interval to 23 seconds

<debug> [1549972898.4219] device[0xaaaaf163c990] (wlan0): remove_pending_action (0): 'recheck-available'

<info>  [1549972898.4221] manager: startup complete

<warn>  [1549972908.4011] device (wlan0): re-acquiring supplicant interface (#1).

<debug> [1549972908.4013] supplicant: (wlan0): creating new supplicant interface

<debug> [1549972908.4015] sup-iface[0xaaaaf15ab2e0,wlan0]: adding interface to supplicant

<debug> [1549972908.4019] device[0xaaaaf163c990] (wlan0): add_pending_action (1): 'waiting-for-supplicant'

<error> [1549972933.4303] sup-iface[0xaaaaf15ab2e0,wlan0]: error adding interface: Timeout was reached

<info>  [1549972933.4306] device (wlan0): supplicant interface state: starting -> down

<debug> [1549972933.4308] device[0xaaaaf163c990] (wlan0): add_pending_action (2): 'recheck-available'

<debug> [1549972933.4309] device[0xaaaaf163c990] (wlan0): remove_pending_action (1): 'waiting-for-supplicant'

<debug> [1549972933.4310] device[0xaaaaf163c990] (wlan0): wifi-scan: reset interval to 23 seconds

<debug> [1549972933.4313] device[0xaaaaf163c990] (wlan0): remove_pending_action (0): 'recheck-available'

<warn>  [1549972943.4005] device (wlan0): re-acquiring supplicant interface (#2).

<debug> [1549972943.4007] supplicant: (wlan0): creating new supplicant interface

<debug> [1549972943.4009] sup-iface[0xaaaaf15ab390,wlan0]: adding interface to supplicant

<debug> [1549972943.4012] device[0xaaaaf163c990] (wlan0): add_pending_action (1): 'waiting-for-supplicant'

<error> [1549972968.4296] sup-iface[0xaaaaf15ab390,wlan0]: error adding interface: Timeout was reached

<info>  [1549972968.4299] device (wlan0): supplicant interface state: starting -> down

<debug> [1549972968.4301] device[0xaaaaf163c990] (wlan0): add_pending_action (2): 'recheck-available'

<debug> [1549972968.4302] device[0xaaaaf163c990] (wlan0): remove_pending_action (1): 'waiting-for-supplicant'

<debug> [1549972968.4303] device[0xaaaaf163c990] (wlan0): wifi-scan: reset interval to 23 seconds

<debug> [1549972968.4307] device[0xaaaaf163c990] (wlan0): remove_pending_action (0): 'recheck-available'

<warn>  [1549972978.4009] device (wlan0): re-acquiring supplicant interface (#3).

<debug> [1549972978.4012] supplicant: (wlan0): creating new supplicant interface

<debug> [1549972978.4014] sup-iface[0xaaaaf15ab440,wlan0]: adding interface to supplicant

<debug> [1549972978.4021] device[0xaaaaf163c990] (wlan0): add_pending_action (1): 'waiting-for-supplicant'

<error> [1549973003.4305] sup-iface[0xaaaaf15ab440,wlan0]: error adding interface: Timeout was reached

<info>  [1549973003.4308] device (wlan0): supplicant interface state: starting -> down

<debug> [1549973003.4310] device[0xaaaaf163c990] (wlan0): add_pending_action (2): 'recheck-available'

<debug> [1549973003.4311] device[0xaaaaf163c990] (wlan0): remove_pending_action (1): 'waiting-for-supplicant'

<debug> [1549973003.4312] device[0xaaaaf163c990] (wlan0): wifi-scan: reset interval to 23 seconds

<debug> [1549973003.4315] device[0xaaaaf163c990] (wlan0): remove_pending_action (0): 'recheck-available'

<warn>  [1549973013.3950] device (wlan0): re-acquiring supplicant interface (#4).

<debug> [1549973013.3952] supplicant: (wlan0): creating new supplicant interface

<debug> [1549973013.3954] sup-iface[0xaaaaf15ab4f0,wlan0]: adding interface to supplicant

<debug> [1549973013.3958] device[0xaaaaf163c990] (wlan0): add_pending_action (1): 'waiting-for-supplicant'

<error> [1549973038.4242] sup-iface[0xaaaaf15ab4f0,wlan0]: error adding interface: Timeout was reached

<info>  [1549973038.4245] device (wlan0): supplicant interface state: starting -> down

<debug> [1549973038.4247] device[0xaaaaf163c990] (wlan0): add_pending_action (2): 'recheck-available'

<debug> [1549973038.4248] device[0xaaaaf163c990] (wlan0): remove_pending_action (1): 'waiting-for-supplicant'

<debug> [1549973038.4249] device[0xaaaaf163c990] (wlan0): wifi-scan: reset interval to 23 seconds

<debug> [1549973038.4252] device[0xaaaaf163c990] (wlan0): remove_pending_action (0): 'recheck-available'

<warn>  [1549973048.4004] device (wlan0): re-acquiring supplicant interface (#5).

<debug> [1549973048.4006] supplicant: (wlan0): creating new supplicant interface

<debug> [1549973048.4008] sup-iface[0xaaaaf15ab5a0,wlan0]: adding interface to supplicant

<debug> [1549973048.4012] device[0xaaaaf163c990] (wlan0): add_pending_action (1): 'waiting-for-supplicant'

<error> [1549973073.4296] sup-iface[0xaaaaf15ab5a0,wlan0]: error adding interface: Timeout was reached

<info>  [1549973073.4300] device (wlan0): supplicant interface state: starting -> down

<debug> [1549973073.4301] device[0xaaaaf163c990] (wlan0): add_pending_action (2): 'recheck-available'

<debug> [1549973073.4302] device[0xaaaaf163c990] (wlan0): remove_pending_action (1): 'waiting-for-supplicant'

<debug> [1549973073.4304] device[0xaaaaf163c990] (wlan0): wifi-scan: reset interval to 23 seconds

<info>  [1549973073.4305] device (wlan0): supplicant interface keeps failing, giving up

<debug> [1549973073.4308] device[0xaaaaf163c990] (wlan0): remove_pending_action (0): 'recheck-available'

 

After NM starts there is a wpa_supplicant instance running:

 

# ps | grep wpa

2236 root      7280 S    /usr/sbin/wpa_supplicant -u -O /var/run/wpa_supplicant

2243 root      3296 S    grep wpa

#

 

The wireless interface is working fine because I can perform a scan with the iw tool:

 

# iw dev wlan0 scan

 

 

Notice that the wpa-supplicant version used is 2.6 and until now it was working fine with the NetworkManager version 1.8.2

Finally, only a few times after several retries the NetworkManager is able to add the wlan0 interface and then all start working fine, but the rate is less than the 5%.

This is a trace when NM is able to add the wireless interface to the supplicant:

 

<error> [1549914689.2504] sup-iface[0xaaaaef5df0d0,wlan0]: error adding interface: Timeout was reached

<info>  [1549914689.2507] device (wlan0): supplicant interface state: starting -> down

<debug> [1549914689.2509] device[0xaaaaef673890] (wlan0): add_pending_action (2): 'recheck-available'

<debug> [1549914689.2510] device[0xaaaaef673890] (wlan0): remove_pending_action (1): 'waiting-for-supplicant'

<debug> [1549914689.2511] device[0xaaaaef673890] (wlan0): wifi-scan: reset interval to 23 seconds

<debug> [1549914689.2515] device[0xaaaaef673890] (wlan0): remove_pending_action (0): 'recheck-available'

<info>  [1549914689.2517] manager: startup complete

<warn>  [1549914699.3738] device (wlan0): re-acquiring supplicant interface (#1).

<debug> [1549914699.3741] supplicant: (wlan0): creating new supplicant interface

<debug> [1549914699.3743] sup-iface[0xaaaaef5df2e0,wlan0]: adding interface to supplicant

<debug> [1549914699.3746] device[0xaaaaef673890] (wlan0): add_pending_action (1): 'waiting-for-supplicant'

<error> [1549964339.4772] sup-iface[0xaaaaef5df2e0,wlan0]: error adding interface: Timeout was reached

<info>  [1549964339.4776] device (wlan0): supplicant interface state: starting -> down

<debug> [1549964339.4778] device[0xaaaaef673890] (wlan0): add_pending_action (2): 'recheck-available'

<debug> [1549964339.4779] device[0xaaaaef673890] (wlan0): remove_pending_action (1): 'waiting-for-supplicant'

<debug> [1549964339.4780] device[0xaaaaef673890] (wlan0): wifi-scan: reset interval to 23 seconds

<debug> [1549964339.4783] device[0xaaaaef673890] (wlan0): remove_pending_action (0): 'recheck-available'

<warn>  [1549964349.4476] device (wlan0): re-acquiring supplicant interface (#2).

<debug> [1549964349.4478] supplicant: (wlan0): creating new supplicant interface

<debug> [1549964349.4480] sup-iface[0xaaaaef5df390,wlan0]: adding interface to supplicant

<debug> [1549964349.4484] device[0xaaaaef673890] (wlan0): add_pending_action (1): 'waiting-for-supplicant'

<error> [1549964374.4769] sup-iface[0xaaaaef5df390,wlan0]: error adding interface: Timeout was reached

<info>  [1549964374.4772] device (wlan0): supplicant interface state: starting -> down

<debug> [1549964374.4774] device[0xaaaaef673890] (wlan0): add_pending_action (2): 'recheck-available'

<debug> [1549964374.4775] device[0xaaaaef673890] (wlan0): remove_pending_action (1): 'waiting-for-supplicant'

<debug> [1549964374.4776] device[0xaaaaef673890] (wlan0): wifi-scan: reset interval to 23 seconds

<debug> [1549964374.4780] device[0xaaaaef673890] (wlan0): remove_pending_action (0): 'recheck-available'

<warn>  [1549964384.4482] device (wlan0): re-acquiring supplicant interface (#3).

<debug> [1549964384.4485] supplicant: (wlan0): creating new supplicant interface

<debug> [1549964384.4486] sup-iface[0xaaaaef5df440,wlan0]: adding interface to supplicant

<debug> [1549964384.4494] device[0xaaaaef673890] (wlan0): add_pending_action (1): 'waiting-for-supplicant'

<error> [1549964409.4779] sup-iface[0xaaaaef5df440,wlan0]: error adding interface: Timeout was reached

<info>  [1549964409.4783] device (wlan0): supplicant interface state: starting -> down

<debug> [1549964409.4784] device[0xaaaaef673890] (wlan0): add_pending_action (2): 'recheck-available'

<debug> [1549964409.4785] device[0xaaaaef673890] (wlan0): remove_pending_action (1): 'waiting-for-supplicant'

<debug> [1549964409.4786] device[0xaaaaef673890] (wlan0): wifi-scan: reset interval to 23 seconds

<debug> [1549964409.4790] device[0xaaaaef673890] (wlan0): remove_pending_action (0): 'recheck-available'

<warn>  [1549964419.4482] device (wlan0): re-acquiring supplicant interface (#4).

<debug> [1549964419.4485] supplicant: (wlan0): creating new supplicant interface

<debug> [1549964419.4487] sup-iface[0xaaaaef5df4f0,wlan0]: adding interface to supplicant

<debug> [1549964419.4491] device[0xaaaaef673890] (wlan0): add_pending_action (1): 'waiting-for-supplicant'

<error> [1549964444.4775] sup-iface[0xaaaaef5df4f0,wlan0]: error adding interface: Timeout was reached

<info>  [1549964444.4779] device (wlan0): supplicant interface state: starting -> down

<debug> [1549964444.4780] device[0xaaaaef673890] (wlan0): add_pending_action (2): 'recheck-available'

<debug> [1549964444.4781] device[0xaaaaef673890] (wlan0): remove_pending_action (1): 'waiting-for-supplicant'

<debug> [1549964444.4782] device[0xaaaaef673890] (wlan0): wifi-scan: reset interval to 23 seconds

<debug> [1549964444.4786] device[0xaaaaef673890] (wlan0): remove_pending_action (0): 'recheck-available'

<warn>  [1549964454.4478] device (wlan0): re-acquiring supplicant interface (#5).

<debug> [1549964454.4480] supplicant: (wlan0): creating new supplicant interface

<debug> [1549964454.4482] sup-iface[0xaaaaef5df5a0,wlan0]: adding interface to supplicant

<debug> [1549964454.4486] device[0xaaaaef673890] (wlan0): add_pending_action (1): 'waiting-for-supplicant'

<debug> [1549964474.4126] sup-iface[0xaaaaef5df5a0,wlan0]: interface added to supplicant

<info>  [1549964474.4217] sup-iface[0xaaaaef5df5a0,wlan0]: supports 5 scan SSIDs

<debug> [1549964474.4248] sup-iface[0xaaaaef5df5a0,wlan0]: supplicant supports network credentials requests

<info>  [1549964474.4251] device (wlan0): supplicant interface state: starting -> ready

<debug> [1549964474.4252] device[0xaaaaef673890] (wlan0): supplicant ready

<debug> [1549964474.4253] device[0xaaaaef673890] (wlan0): add_pending_action (2): 'recheck-available'

<debug> [1549964474.4255] device[0xaaaaef673890] (wlan0): remove_pending_action (1): 'waiting-for-supplicant'

<debug> [1549964474.4257] device[0xaaaaef673890] (wlan0): add_pending_action (2): 'queued-state-change-disconnected'

<debug> [1549964474.4258] device[0xaaaaef673890] (wlan0): queue-state[disconnected, reason:supplicant-available, id:229]: queue state change

<debug> [1549964474.4259] device[0xaaaaef673890] (wlan0): is available, will transition to disconnected

<debug> [1549964474.4260] device[0xaaaaef673890] (wlan0): remove_pending_action (1): 'recheck-available'

<debug> [1549964474.4262] device[0xaaaaef673890] (wlan0): queue-state[disconnected, reason:supplicant-available, id:229]: change state

<info>  [1549964474.4263] device (wlan0): state change: unavailable -> disconnected (reason 'supplicant-available', sys-iface-state: 'managed')

<debug> [1549964474.4265] device[0xaaaaef673890] (wlan0): will enable userland IPv6LL

<debug> [1549964474.4266] platform-linux: link: change 6: user-ipv6ll: set IPv6 address generation mode to none

<debug> [1549964474.4268] platform-linux: do-request-link: 6

<debug> [1549964474.4272] platform-linux: do-change-link[6]: success changing link: success

<debug> [1549964474.4275] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/disable_ipv6' to '1' (current value is '0')

<debug> [1549964474.4277] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/disable_ipv6' to '0' (current value is '1')

<debug> [1549964474.4279] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_defrtr' to '0' (current value is identical)

<debug> [1549964474.4281] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra_pinfo' to '0' (current value is identical)

<debug> [1549964474.4283] platform-linux: sysctl: failed to open '/proc/sys/net/ipv6/conf/wlan0/accept_ra_rtr_pref': (2) No such file or directory

<debug> [1549964474.4285] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/use_tempaddr' to '0' (current value is identical)

<debug> [1549964474.4287] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/forwarding' to '0' (current value is identical)

<debug> [1549964474.4313] device[0xaaaaef673890] (wlan0): wifi-scan: scanning requested

<debug> [1549964474.4315] device[0xaaaaef673890] (wlan0): wifi-scan: no SSIDs to probe scan

<debug> [1549964474.4327] device[0xaaaaef673890] (wlan0): add_pending_action (2): 'wifi-scan'

<debug> [1549964474.4329] device[0xaaaaef673890] (wlan0): wifi-scan: scheduled in 3 seconds (interval now 23 seconds)

<debug> [1549964474.4330] device[0xaaaaef673890] (wlan0): remove_pending_action (1): 'queued-state-change-disconnected'

<debug> [1549964474.4398] device[0xaaaaef673890] (wlan0): wifi-scan: scanning-state: scanning

<debug> [1549964477.9353] device[0xaaaaef673890] (wlan0): wifi-scan: scanning-state: idle

<debug> [1549964477.9523] device[0xaaaaef673890] (wlan0): failed to match hidden AP 6C:99:89:76:43:9F

<debug> [1549964477.9689] device[0xaaaaef673890] (wlan0): failed to match hidden AP 6C:99:89:76:43:9E

<debug> [1549964477.9856] device[0xaaaaef673890] (wlan0): failed to match hidden AP 6C:99:89:76:43:91

<debug> [1549964477.9884] device[0xaaaaef673890] (wlan0): failed to match hidden AP 6C:99:89:76:43:90

<debug> [1549964477.9937] device[0xaaaaef673890] (wlan0): failed to match hidden AP E0:0E:DA:38:C1:CF

<debug> [1549964478.0017] device[0xaaaaef673890] (wlan0): failed to match hidden AP E0:0E:DA:38:C1:C0

<debug> [1549964478.0070] device[0xaaaaef673890] (wlan0): failed to match hidden AP E0:0E:DA:38:C1:C1

<debug> [1549964478.0279] device[0xaaaaef673890] (wlan0): failed to match hidden AP 6C:99:89:76:43:9C

<debug> [1549964478.0309] device[0xaaaaef673890] (wlan0): failed to match hidden AP 6C:99:89:76:43:93

<debug> [1549964478.0339] device[0xaaaaef673890] (wlan0): failed to match hidden AP E0:0E:DA:38:C1:CC

<debug> [1549964478.0368] device[0xaaaaef673890] (wlan0): failed to match hidden AP E0:0E:DA:38:C1:C3

<debug> [1549964478.0640] device[0xaaaaef673890] (wlan0): wifi-scan: scan-done callback: successful

<debug> [1549964478.0647] device[0xaaaaef673890] (wlan0): wifi-scan: scheduled in 23 seconds (interval now 33 seconds)

<debug> [1549964478.0649] device[0xaaaaef673890] (wlan0): add_pending_action (2): 'autoactivate'

<debug> [1549964478.0650] device[0xaaaaef673890] (wlan0): remove_pending_action (1): 'wifi-scan'

<debug> [1549964478.0654] device[0xaaaaef673890] (wlan0): remove_pending_action (0): 'autoactivate'

<debug> [1549964501.4611] device[0xaaaaef673890] (wlan0): wifi-scan: scanning requested

<debug> [1549964501.4615] device[0xaaaaef673890] (wlan0): wifi-scan: no SSIDs to probe scan

<debug> [1549964501.4621] device[0xaaaaef673890] (wlan0): add_pending_action (1): 'wifi-scan'

<debug> [1549964501.4623] device[0xaaaaef673890] (wlan0): wifi-scan: scheduled in 33 seconds (interval now 43 seconds)

<debug> [1549964501.4703] device[0xaaaaef673890] (wlan0): wifi-scan: scanning-state: scanning

<debug> [1549964504.9232] device[0xaaaaef673890] (wlan0): wifi-scan: scanning-state: idle

<debug> [1549964504.9425] device[0xaaaaef673890] (wlan0): failed to match hidden AP 4C:1B:86:00:6D:B3

<debug> [1549964504.9860] device[0xaaaaef673890] (wlan0): wifi-scan: scan-done callback: successful

<debug> [1549964504.9866] device[0xaaaaef673890] (wlan0): add_pending_action (2): 'autoactivate'

<debug> [1549964504.9868] device[0xaaaaef673890] (wlan0): remove_pending_action (1): 'wifi-scan'

<debug> [1549964504.9873] device[0xaaaaef673890] (wlan0): remove_pending_action (0): 'autoactivate'

 

 

Does anyone have any clue to find the problem here?

 

Thanks in advance.

 

Arturo.

 

 

 



[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]