[Comm] P8, 4.7.2-un-def - не запускается сеть после просыпания (как проводная так и wifi)

Чт Сен 15 16:34:33 MSK 2016

На Wed, 14 Sep 2016 20:47:48 +0300
Mikhail Efremov <sem на altlinux.org> писал:

> On Tue, 13 Sep 2016 18:24:11 +0300 Maks Re wrote:
> > Здравствуйте,
> > 
> > Здравствуйте,
> > 
> > P8, 4.7.2-un-def - не запускается сеть после просыпания (как проводная так и wifi)
> > 
> > т.е. закрыли крышку ноута,
> > а потом, окрыв можно очень долго ждать когда сеть поднимиться....
> > 
> > это регресия, недоработка,
> > стоит чего-то ждать?  
> 
> Покажите лог NM.
> 

вот сообщения от сервиса NM, после просыпания

# service NetworkManager 
● NetworkManager.service - Network Manager
   Loaded: loaded (/lib/systemd/system/NetworkManager.service; enabled; vendor preset: enabled)
   Active: active (running) since Чт 2016-09-15 00:41:25 MSK; 12h ago
     Docs: man:NetworkManager(8)
  Process: 702 ExecStartPre=/usr/sbin/NetworkManager-prestart (code=exited, status=0/SUCCESS)
 Main PID: 838 (NetworkManager)
    Tasks: 4 (limit: 512)
   CGroup: /system.slice/NetworkManager.service
           └─838 /usr/sbin/NetworkManager --no-daemon

сен 15 13:19:18 lynx.localdomain NetworkManager[838]: <warn>  [1473934758.2180] sup-iface[0x99d610,wlan0]: connection disconnected (reason -3)
сен 15 13:19:18 lynx.localdomain NetworkManager[838]: <info>  [1473934758.2238] manager: wake requested (sleeping: yes  enabled: yes)
сен 15 13:19:18 lynx.localdomain NetworkManager[838]: <info>  [1473934758.2238] manager: waking up...
сен 15 13:19:18 lynx.localdomain NetworkManager[838]: <info>  [1473934758.2239] device (eth0): state change: unavailable -> unmanaged (reason 'sleeping') [20 10
сен 15 13:19:18 lynx.localdomain NetworkManager[838]: <info>  [1473934758.3375] device (eth0): state change: unmanaged -> unavailable (reason 'managed') [10 20 
сен 15 13:19:18 lynx.localdomain NetworkManager[838]: <info>  [1473934758.6041] manager: NetworkManager state is now DISCONNECTED
сен 15 13:19:18 lynx.localdomain NetworkManager[838]: <info>  [1473934758.6151] device (wlan0): supplicant interface state: disconnected -> disabled
сен 15 13:19:18 lynx.localdomain NetworkManager[838]: <info>  [1473934758.6153] device (wlan0): supplicant interface state: disabled -> disconnected
сен 15 13:19:18 lynx.localdomain NetworkManager[838]: <info>  [1473934758.6191] device (wlan0): state change: disconnected -> unmanaged (reason 'sleeping') [30 
сен 15 13:19:18 lynx.localdomain NetworkManager[838]: <info>  [1473934758.6273] device (wlan0): set-hw-addr: reset MAC address to 74:E5:0B:18:F6:70 (unmanage)

# service NetworkManager restart
# service NetworkManager 
● NetworkManager.service - Network Manager
   Loaded: loaded (/lib/systemd/system/NetworkManager.service; enabled; vendor preset: enabled)
   Active: active (running) since Чт 2016-09-15 13:20:05 MSK; 4s ago
     Docs: man:NetworkManager(8)
  Process: 3551 ExecStartPre=/usr/sbin/NetworkManager-prestart (code=exited, status=0/SUCCESS)
 Main PID: 3578 (NetworkManager)
    Tasks: 5 (limit: 512)
   CGroup: /system.slice/NetworkManager.service
           ├─3578 /usr/sbin/NetworkManager --no-daemon
           └─3843 /sbin/dhclient -d -q -sf /usr/lib/NetworkManager/nm-dhcp-helper -pf /var/run/dhclient-wlan0.pid -lf /var/lib/NetworkManager/dhclient-64bfe72e-

сен 15 13:20:07 lynx.localdomain NetworkManager[3578]: <info>  [1473934807.0845] device (wlan0): supplicant interface state: inactive -> authenticating
сен 15 13:20:07 lynx.localdomain NetworkManager[3578]: <info>  [1473934807.0909] device (wlan0): supplicant interface state: authenticating -> associating
сен 15 13:20:07 lynx.localdomain NetworkManager[3578]: <info>  [1473934807.1137] device (wlan0): supplicant interface state: associating -> associated
сен 15 13:20:07 lynx.localdomain NetworkManager[3578]: <info>  [1473934807.8897] device (wlan0): supplicant interface state: associated -> 4-way handshake
сен 15 13:20:07 lynx.localdomain NetworkManager[3578]: <info>  [1473934807.8982] device (wlan0): supplicant interface state: 4-way handshake -> completed
сен 15 13:20:07 lynx.localdomain NetworkManager[3578]: <info>  [1473934807.8984] device (wlan0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful. 
сен 15 13:20:07 lynx.localdomain NetworkManager[3578]: <info>  [1473934807.8985] device (wlan0): state change: config -> ip-config (reason 'none') [50 70 0]
сен 15 13:20:07 lynx.localdomain NetworkManager[3578]: <info>  [1473934807.9007] dhcp4 (wlan0): activation: beginning transaction (timeout in 45 seconds)
сен 15 13:20:07 lynx.localdomain NetworkManager[3578]: <info>  [1473934807.9033] dhcp4 (wlan0): dhclient started with pid 3843
сен 15 13:20:07 lynx.localdomain dhclient[3843]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 4

и через некоторое время...

# service NetworkManager 
● NetworkManager.service - Network Manager
   Loaded: loaded (/lib/systemd/system/NetworkManager.service; enabled; vendor preset: enabled)
   Active: active (running) since Чт 2016-09-15 13:20:05 MSK; 26s ago
     Docs: man:NetworkManager(8)
  Process: 3551 ExecStartPre=/usr/sbin/NetworkManager-prestart (code=exited, status=0/SUCCESS)
 Main PID: 3578 (NetworkManager)
    Tasks: 4 (limit: 512)
   CGroup: /system.slice/NetworkManager.service
           ├─3578 /usr/sbin/NetworkManager --no-daemon
           └─3843 /sbin/dhclient -d -q -sf /usr/lib/NetworkManager/nm-dhcp-helper -pf /var/run/dhclient-wlan0.pid -lf /var/lib/NetworkManager/dhclient-64bfe72e-

сен 15 13:20:11 lynx.localdomain NetworkManager[3578]: <info>  [1473934811.5260] device (wlan0): state change: ip-config -> ip-check (reason 'none') [70 80 0]
сен 15 13:20:11 lynx.localdomain dhclient[3843]: bound to 192.168.1.85 -- renewal in 36875 seconds.
сен 15 13:20:11 lynx.localdomain NetworkManager[3578]: <info>  [1473934811.5478] device (wlan0): state change: ip-check -> secondaries (reason 'none') [80 90 0]
сен 15 13:20:11 lynx.localdomain NetworkManager[3578]: <info>  [1473934811.5486] device (wlan0): state change: secondaries -> activated (reason 'none') [90 100 
сен 15 13:20:11 lynx.localdomain NetworkManager[3578]: <info>  [1473934811.5555] manager: NetworkManager state is now CONNECTED_LOCAL
сен 15 13:20:11 lynx.localdomain NetworkManager[3578]: <info>  [1473934811.5842] manager: NetworkManager state is now CONNECTED_GLOBAL
сен 15 13:20:11 lynx.localdomain NetworkManager[3578]: <info>  [1473934811.5940] policy: set 'off1ce' (wlan0) as default for IPv4 routing and DNS
сен 15 13:20:11 lynx.localdomain NetworkManager[3578]: <info>  [1473934811.6066] dns-mgr: Writing DNS information to /sbin/resolvconf
сен 15 13:20:29 lynx.localdomain NetworkManager[3578]: <info>  [1473934829.8774] device (wlan0): Activation: successful, device activated.
сен 15 13:20:29 lynx.localdomain NetworkManager[3578]: <info>  [1473934829.8783] manager: startup complete

а где лог NM взять?