Dlouhé čekání na přidělení IP adresy

[Migilenik]

Zdravím,

čistě ze zájmu o tuto platformu jsem si domů pořídil Mikrotik RB751G-2HnD, přičemž se mi zatím zdařilo nastavit vše, po čem má domácí síť prahla. Mám nicméně problém s rychlostí přidělování IP adres lokálním stanicím skrze dhcp server(y). Problém se projevoval už i s defaultním nastavením , takže to snad nebude nějakou zjevnou chybou v nastavení.

Na všech stanicích mi běží Debian 7.0 se správcem sítě (Wicd), kterému při komunikaci s Mikrotikem trvá i více než 10 sekund, než z routeru získá IP adresu (Obtaining IP address). Pro srovnání, při komunikaci s postarším TP-Link WR740N, to trvá maximálně vteřinu.

Tato časová prodleva je vidět i v logu Wicd:

Mikrotik s defaultním nastavením a defaultním subnetem:

Kód: Vybrat vše

DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 7
2012/08/22 21:56:35 :: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 18
2012/08/22 21:56:35 :: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
2012/08/22 21:56:35 :: DHCPOFFER from 192.168.88.1
2012/08/22 21:56:35 :: DHCPACK from 192.168.88.1
2012/08/22 21:56:35 :: bound to 192.168.88.254 -- renewal in 124583 seconds.
2012/08/22 21:56:35 :: DHCP connection successful
2012/08/22 [b]21:56:35[/b] :: not verifying
2012/08/22 [b]21:56:47[/b] :: Connecting thread exiting.
2012/08/22 21:56:48 :: Sending connection attempt result success

TP-Link:

Kód: Vybrat vše

2012/08/22 21:26:23 :: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
2012/08/22 21:26:23 :: DHCPOFFER from 192.168.1.1
2012/08/22 21:26:23 :: DHCPACK from 192.168.1.1
2012/08/22 21:26:23 :: bound to 192.168.1.3 -- renewal in 2147483648 seconds.
2012/08/22 21:26:23 :: DHCP connection successful
2012/08/22 [b]21:26:23[/b] :: not verifying
2012/08/22 [b]21:26:24[/b] :: Connecting thread exiting.
2012/08/22 21:26:24 :: Sending connection attempt result success

Problém se projevuje na všech stanicích a sítích (ethernet i wifi) a to i když wicd vypnu a pracuji se sítí přímo v terminálu. V tom trvá daných deset sekund, než je úspěšně dokončen proces "bound address".

Nevím, zda to k něčemu bude, nicméně zde jsou výpisy některých nastavení:

Kód: Vybrat vše

[admin@MikroTik] /ip dhcp-server> print
Flags: X - disabled, I - invalid
 #   NAME     INTERFACE     RELAY           ADDRESS-POOL     LEASE-TIME ADD-ARP
 0   dhcp2    ether2-mas...                 dhcp_pool2       3d       
 1   dhcp3    ether5-zal...                 dhcp_pool3       3d       
 2   dhcp1    wlan1                         dhcp_pool1       3d

Kód: Vybrat vše

[admin@MikroTik] /ip pool> print
 # NAME                                         RANGES                         
 0 dhcp_pool1                                   192.168.1.2-192.168.1.254     
 1 dhcp_pool2                                   192.168.2.2-192.168.2.254     
 2 dhcp_pool3                                   192.168.3.2-192.168.3.254

Kód: Vybrat vše

[admin@MikroTik] /ip address> print
Flags: X - disabled, I - invalid, D - dynamic
 #   ADDRESS            NETWORK         INTERFACE                             
 0   192.168.1.1/24     192.168.1.0     wlan1                                 
 1   192.168.2.1/24     192.168.2.0     ether2-master-local                   
 2   192.168.3.1/24     192.168.3.0     ether5-zaloha

Nutno poznamenat, že až na tuto časovou prodlevu probíhá přidělování naprosto v pořádku a to včetně adres, které mám přednastavené pro určitá zařízení pevně.

[tom-tom]

Nemáš u toho DHCP serveru v mikrotiku nastaveno authoritative=after 10s delay? Když mluvíš o těch 10s...
Toto je můj výpis nastavení serveru:
name="dhcp-ethernet" interface=ether1 lease-time=1h address-pool=dhcp1 add-arp=yes authoritative=yes always-broadcast=yes

[Migilenik]

To už mě take napadlo ale těch 10s delay nastavene nemam. Až se vratim z prace prubnu tvoje nastavení.

[Migilenik]

Tak to bohužel nepomohlo. Obtaining address stale trva kolem 10 vteřin.

[tom-tom]

Přidej si na mikrotiku v system/logging/rules pravidlo s topic=dhcp a action=memory. Mikrotik bude do logu vypisovat podrobnější info o dhcp.
Potom nechej některý pc přihlásit do sítě. Zajímalo by mě, s jakými časy se to přidělování zobrazí v logu mikrotiku.

[Migilenik]

jdu na to, nicméně si začínám myslet, že dhcp server není na vině. Časová prodleva se projevuje i při použití statických adres.

viz log z wicd

Kód: Vybrat vše

2012/08/27 21:17:58 :: Flushing the routing table...
2012/08/27 21:17:58 :: Putting interface up...
2012/08/27 21:18:00 :: Setting static IP : 192.168.3.10
2012/08/27 21:18:01 :: Setting default gateway : 192.168.3.1
2012/08/27 21:18:13 :: Connecting thread exiting.
2012/08/27 21:18:13 :: Sending connection attempt result success

[Migilenik]

Na první pohled jsem neobjevil žádne tlačitko "download" pro stažení logů,, takže prozatím postnu aspon screenshot. BTW ten poslední záznam o přihlášení je reload stránky.


K tomu log wicd z daneho stroje:

Kód: Vybrat vše

2012/08/27 21:48:00 :: Connecting to wireless network MikroTik
2012/08/27 21:48:00 :: attempting to set hostname with dhclient
2012/08/27 21:48:00 :: using dhcpcd or another supported client may work better
2012/08/27 21:48:01 :: attempting to set hostname with dhclient
2012/08/27 21:48:01 :: using dhcpcd or another supported client may work better
2012/08/27 21:48:01 :: Putting interface down
2012/08/27 21:48:01 :: Releasing DHCP leases...
2012/08/27 21:48:01 :: attempting to set hostname with dhclient
2012/08/27 21:48:01 :: using dhcpcd or another supported client may work better
2012/08/27 21:48:01 :: Setting false IP...
2012/08/27 21:48:01 :: Stopping wpa_supplicant
2012/08/27 21:48:01 :: Flushing the routing table...
2012/08/27 21:48:01 :: Putting interface up...
2012/08/27 21:48:03 :: Attempting to authenticate...
2012/08/27 21:48:05 :: Running DHCP with hostname Defiant
2012/08/27 21:48:05 :: attempting to set hostname with dhclient
2012/08/27 21:48:05 :: using dhcpcd or another supported client may work better
2012/08/27 21:48:05 :: Internet Systems Consortium DHCP Client 4.2.2
2012/08/27 21:48:05 :: Copyright 2004-2011 Internet Systems Consortium.
2012/08/27 21:48:05 :: All rights reserved.
2012/08/27 21:48:05 :: For info, please visit https://www.isc.org/software/dhcp/
2012/08/27 21:48:05 ::
2012/08/27 21:48:05 :: Listening on LPF/wlan0/00:26:c7:70:6f:ee
2012/08/27 21:48:05 :: Sending on   LPF/wlan0/00:26:c7:70:6f:ee
2012/08/27 21:48:05 :: Sending on   Socket/fallback
2012/08/27 21:48:05 :: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 5
2012/08/27 21:48:05 :: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
2012/08/27 21:48:05 :: DHCPOFFER from 192.168.1.1
2012/08/27 21:48:05 :: DHCPACK from 192.168.1.1
2012/08/27 21:48:05 :: bound to 192.168.1.3 -- renewal in 103155 seconds.
2012/08/27 21:48:05 :: DHCP connection successful
2012/08/27 21:48:05 :: not verifying
2012/08/27 21:48:17 :: Connecting thread exiting.
2012/08/27 21:48:17 :: Sending connection attempt result success

Ta časova prodleva (poslední dva řadky) se bohužel projevuje tam, kde mikrotik žadny log nevypsal.

[zdenek.svarc]

Mně to celé přijde na záležitost spojenou s DNS resolvingem na straně klienta (Debian). Jak tam vypadá /etc/hosts?

[Migilenik]

Kód: Vybrat vše

root@Defiant:~$ cat /etc/hosts
127.0.0.1   localhost
127.0.1.1   Defiant.Starfleet   Defiant

UPDATE:

Stale se mi tomu nechce věřit, nicméně to vypadá, že problém bude v samotném Wicd. Nabootoval jsem LiveUSB Xubuntu, který ve výchozím stavu používá správce sítě "Network-Manager", a připojení na Mikrotik probíhá standardní rychlostí, zatímco doinstalovaný wicd se tam opět neúměrně vleče (v logu to samé zpoždění).

[tom-tom]

Mě zaujalo, že ti to v logu neustále vypisuje "using dhcpcd or another supported client may work better"
Co když mu ho dopřeješ a zkusíš to znova?

[Migilenik]

Když dhclient konečně začal fungovat dle mých představ . Nu což, zkusím, poreferuji.

[Migilenik]

Tak jsem vyzkousel ten dhcpcd, zpožděni se však stale projevuje, viz. log. Odcházím prudit na fóra wicd, mějte se a díky za pomoc.

Komunikace s TP Linkem:

Kód: Vybrat vše

2012/08/28 20:34:42 :: Connecting to wireless network Topolink
2012/08/28 20:34:43 :: Putting interface down
2012/08/28 20:34:43 :: Releasing DHCP leases...
2012/08/28 20:34:43 :: Setting false IP...
2012/08/28 20:34:43 :: Stopping wpa_supplicant
2012/08/28 20:34:43 :: Flushing the routing table...
2012/08/28 20:34:43 :: Putting interface up...
2012/08/28 20:34:45 :: Attempting to authenticate...
2012/08/28 20:34:46 :: Running DHCP with hostname Intrepid
2012/08/28 20:34:48 :: dhcpcd.sh: interface wlan0 has been configured with new IP=192.168.1.3
2012/08/28 20:34:48 ::
2012/08/28 20:34:48 ::
2012/08/28 20:34:48 :: DHCP connection successful
2012/08/28 20:34:48 :: not verifying
2012/08/28 20:34:48 :: Connecting thread exiting.
2012/08/28 20:34:48 :: Sending connection attempt result success

a s Mikrotikem:

Kód: Vybrat vše

2012/08/28 20:32:53 :: Connecting to wireless network MikroTik
2012/08/28 20:33:05 :: Putting interface down
2012/08/28 20:33:05 :: Releasing DHCP leases...
2012/08/28 20:33:05 :: Setting false IP...
2012/08/28 20:33:05 :: Stopping wpa_supplicant
2012/08/28 20:33:05 :: Flushing the routing table...
2012/08/28 20:33:05 :: Putting interface up...
2012/08/28 20:33:07 :: Attempting to authenticate...
2012/08/28 20:33:10 :: Running DHCP with hostname Intrepid
2012/08/28 20:33:11 :: dhcpcd.sh: interface wlan0 has been configured with new IP=192.168.1.2
2012/08/28 20:33:11 ::
2012/08/28 20:33:11 ::
2012/08/28 20:33:11 :: DHCP connection successful
2012/08/28 20:33:11 :: not verifying                             --> zde je zřejmé zpoždění
2012/08/28 20:33:23 :: Connecting thread exiting.
2012/08/28 20:33:23 :: Sending connection attempt result success

[zdenek.svarc]

Kód: Vybrat vše

root@Defiant:~$ cat /etc/hosts
127.0.0.1   localhost
127.0.1.1   Defiant.Starfleet   Defiant

UPDATE:

Stale se mi tomu nechce věřit, nicméně to vypadá, že problém bude v samotném Wicd. Nabootoval jsem LiveUSB Xubuntu, který ve výchozím stavu používá správce sítě "Network-Manager", a připojení na Mikrotik probíhá standardní rychlostí, zatímco doinstalovaný wicd se tam opět neúměrně vleče (v logu to samé zpoždění).

Rozhození loopbacku na dva řádky je trošku nestandardní, fungovat by mělo, ale pro jistotu bych to napsal na jeden řádek, tedy

Kód: Vybrat vše

127.0.0.1 Defiant.Starfleet Defiant localhost

a jak vypadá cat /etc/resolv.conf?

[Migilenik]

Nevím jak přesně je to v ostatních distribucích, nicméně v debianu to dvouřádkové "rozhození" normální je.

Kód: Vybrat vše

cat /etc/resolv.conf
nameserver 82.144.128.1
nameserver 82.144.129.1

[zdenek.svarc]

Nevím jak přesně je to v ostatních distribucích, nicméně v debianu to dvouřádkové "rozhození" normální je.

Kód: Vybrat vše

cat /etc/resolv.conf
nameserver 82.144.128.1
nameserver 82.144.129.1

Tak jsem se díval na to rozhození loopbacku na dva řádky v /etc/hosts a opravdu je to na debianu běžné. Jsou ty DNS servery, resp. první z nich dobře dostupné? To už hodně vařím z vody.