Você pode pesquisar os registros com algo como sudo zegrep -n 'wpa_supplicant|NetworkManager' /var/log/*
para ver o que está acontecendo.
Depois de olhar o log postado, aqui está como eu analisei.
Análise de var_log.txt ( http://pastebin.com/Y9s3UJMN
), 230 linhas
como:
/var/log/syslog:7607:Dec 18 14:57:52 trav-HP-Pavilion-dv6000-RG360UA-ABA NetworkManager[870]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Demasiada desordem e possivelmente pouca informação. Vamos reduzir
a desordem e ver o que resta. A ferramenta que eu uso para isso é o GNU
Emacs editor, mas você pode usar qualquer editor em uma cópia do arquivo, como fez
Eu.
Todas as linhas começam com " /var/log/syslog:
" - nenhuma informação útil
aqui, delete.
Em seguida, o número da linha (devido à opção -n). Note que há
são lacunas na seqüência de números de linha. As linhas omitidas
(7622-7625, e outras lacunas curtas) são linhas que não contêm
" NetworkManager
" ou " wpa_supplicant
", mas eles podem conter
informação interessante. Isso é algo para você olhar
em. Vamos manter os números das linhas, por enquanto.
Depois, há a data, hora, hostname (que tipo de host é
"%código%"? Substitua (no log) com
" trav-HP-Pavilion-dv6000-RG360UA-ABA
", sem informações perdidas e 31 caracteres de desorganização salvos
por linha) e o processname que fez a entrada de log. Nós apenas
grepped para " trav
" ou " NetworkManager
", então é tudo o que
obteve. Observe que os PIDs (os IDs de processo, em []) permanecem os mesmos,
wpa_supplicant
para [870]
e NetworkManager
para [916]
. Isso significa
que o NetworkManager e o wpa_supplicant NÃO reiniciaram durante este log
fragmento. Cada um deles acha que está funcionando "normalmente".
Finalmente, chegamos à mensagem que foi registrada. Tags do NetworkManager
suas mensagens com "info" ou "warn", o wpa_supplicant não.
Em seguida, olhando as mensagens no primeiro bloco da linha consecutiva
números, 7607 a 7621:
<info> (wlan0): device state change: need-auth -> prepare (reason 'none')
<info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
<info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
<info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
<info> (wlan0): device state change: prepare -> config (reason 'none')
<info> Activation (wlan0/wireless): connection 'Auto Verizon DROIDX 19
<info> Config: added 'ssid' value 'Verizon DROIDX 1980'
<info> Config: added 'scan_ssid' value '1'
<info> Config: added 'key_mgmt' value 'WPA-PSK'
<info> Config: added 'psk' value '<omitted>'
<info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
<info> Config: set interface ap_scan to 1
<info> (wlan0): supplicant interface state: inactive -> scanning
Trying to authenticate with 40:fc:89:29:82:fb (SSID='Verizon DROIDX 19
<info> (wlan0): supplicant interface state: scanning -> authenticating
Vemos o NetworkManager executando o estágio 1 e o estágio 2 (de 5) de ativação.
em seguida, chamando o wpa_supplicant para tentar autenticar usando o SSID
"Verizon DROIDX 1980", endereço MAC 40: fc: 89: 29: 82: fb.
Então, em 18 de dezembro 14:58:02 e a cada 8 segundos depois,
registros wpa-suplicantes:
Trying to authenticate with 40:fc:89:29:82:fb (SSID='Verizon DROIDX 1980' freq=2462 MHz)
Então, em 18 de dezembro 14:58:38, o NetworkManager faz um 'pedido pelo usuário'
desconectar.
Observar essas entradas de log foi uma perda de tempo - começar de novo em
linha 7654 "Ativação (wlan0) da conexão inicial" Verizon DROID2
6182 '", mas desta vez, há algumas informações diferentes:
<info> Activation (wlan0) starting connection 'Verizon DROID2 6182'
<info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
<info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
<info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
<info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
<info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
<info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
<info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
<info> Activation (wlan0/wireless): access point 'Verizon DROID2 6182' has security, but secrets are required.
<info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
<info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Então, às 14:59:27, vemos outra reinicialização sem fio, ainda WPA-PSK,
"segredos" conhecidos, mas com o valor 'auth_alg' adicionado 'OPEN'. Frequência diferente.
get_secret_flags: assertion 'is_secret_prop (setting, secret_name, error)' failed
<info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
<info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
<info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
<info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
<info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
<info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
<info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
<info> Activation (wlan0/wireless): connection 'Verizon DROID2 6182' has security, and secrets exist. No new secrets needed.
<info> Config: added 'ssid' value 'Verizon DROID2 6182'
<info> Config: added 'scan_ssid' value '1'
<info> Config: added 'key_mgmt' value 'WPA-PSK'
<info> Config: added 'auth_alg' value 'OPEN'
<info> Config: added 'psk' value '<omitted>'
<info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
<info> Config: set interface ap_scan to 1
<info> (wlan0): supplicant interface state: disconnected -> scanning
Trying to authenticate with f8:7b:7a:4f:8f:56 (SSID='Verizon DROID2 6182' freq=2437 MHz)
Acaba com o wpa_supplicant tentando um MAC e SSID diferente e
tentando novamente. Em 18 de dezembro às 15:00:27, o NetworkManager expirou:
<warn> Activation (wlan0/wireless): association took too long.
<info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
<warn> Activation (wlan0/wireless): asking for new secrets
<info> (wlan0): supplicant interface state: authenticating -> disconnected
<warn> Couldn't disconnect supplicant interface: This interface is not connected.
get_secret_flags: assertion 'is_secret_prop (setting, secret_name, error)' failed
<info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
<info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
<info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
<info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
<info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
<info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
<info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
<info> Activation (wlan0/wireless): connection 'Verizon DROID2 6182' has security, and secrets exist. No new secrets needed.
<info> Config: added 'ssid' value 'Verizon DROID2 6182'
<info> Config: added 'scan_ssid' value '1'
<info> Config: added 'key_mgmt' value 'WPA-PSK'
<info> Config: added 'auth_alg' value 'OPEN'
<info> Config: added 'psk' value '<omitted>'
<info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
<info> Config: set interface ap_scan to 1
<info> (wlan0): supplicant interface state: disconnected -> scanning
Trying to authenticate with f8:7b:7a:4f:8f:56 (SSID='Verizon DROID2 6182' freq=2437 MHz)
<info> (wlan0): supplicant interface state: scanning -> authenticating
e depois mais "Tentando autenticar", reinicia, terminando às 15:01:36,
"pedindo novos segredos" e avisando "Não foi possível desconectar o suplicante
interface: Esta interface não está conectada. "e" Nenhum agente foi
disponível para este pedido. "que sugere a (falta de) progresso de
a tentativa de conexão / autenticação. O NetworkManager desiste de
'Verizon DROID2 6182', marcando-o como inválido.
Em 18 de dezembro, 15:01:43, o NetworkManager ativa automaticamente o Verizon DROIDX
1980, mas cabe a uma desconexão 'solicitada pelo usuário' às 15:02:22.
Em 15:02:26, o NetworkManager ativa automaticamente o Verizon DROIDX 1980 novamente,
até 15:02:40, quando "desativando o dispositivo (razão
'connection-removed') [38] "acontece.
As perguntas que tenho neste momento são:
Existe alguma informação interessante nas linhas 7622-7625, e outras
lacunas curtas?
Por que usar "40: fc: 89: 29: 82: fb (SSID = 'Verizon DROIDX 1980' freq = 2462 MHz)"
e "f8: 7b: 7a: 4f: 8f: 56 (SSID = 'Verizon DROID2 6182', freq = 2437 MHz)"?
Qual deles está certo?
Você realmente tem a certeza de que tem o WPA?
pré-chave compartilhada digitada corretamente? Se é uma string hexadecimal, tente substituir
[a-f] com [A-F] ou o outro caminho.
Waltinator