Your message dated Sun, 09 May 2021 12:47:41 -0700 (PDT)
with message-id <60983c5d.1c69fb81.152aa.2...@mx.google.com>
and subject line Closing this bug (BTS maintenance for src:linux bugs)
has caused the Debian Bug report #826378,
regarding linux: System immediately wakes up after suspend, faulty wake-on-lan
on 8086:1502 e1000e NIC.
to be marked as done.
This means that you claim that the problem has been dealt with.
If this is not the case it is now your responsibility to reopen the
Bug report if necessary, and/or fix the problem forthwith.
(NB: If you are a system administrator and have no idea what this
message is talking about, this may indicate a serious mail system
misconfiguration somewhere. Please contact ow...@bugs.debian.org
immediately.)
--
826378: https://bugs.debian.org/cgi-bin/bugreport.cgi?bug=826378
Debian Bug Tracking System
Contact ow...@bugs.debian.org with problems
--- Begin Message ---
Source: linux
Severity: normal
Dear Maintainer, my system wakes up immediately after gone to suspend.
It seems to be caused by faulty e1000e wake-on-lan on 8086:1502 NIC. I can
reproduce it
when any wol state is set on NIC except 'd'. Cable is not plugged.
can be worked around by either:
echo GLAN | sudo tee /proc/acpi/wakeup
or
sudo ethtool -s eno1 wol d
################################
Jun 05 07:39:18 hostname systemd-logind[899]: Lid closed.
Jun 05 07:39:18 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:18 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:18 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:18 hostname kernel: pci_bus 0000:01: Allocating resources
Jun 05 07:39:18 hostname kernel: pci_bus 0000:02: Allocating resources
Jun 05 07:39:18 hostname kernel: pci_bus 0000:03: Allocating resources
Jun 05 07:39:18 hostname kernel: pci_bus 0000:07: Allocating resources
Jun 05 07:39:18 hostname kernel: pci_bus 0000:0b: Allocating resources
Jun 05 07:39:18 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:18 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:18 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:18 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:18 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:18 hostname NetworkManager[972]: <info> [1465101558.8718]
manager: sleep requested (sleeping: no enabled: yes)
Jun 05 07:39:18 hostname NetworkManager[972]: <info> [1465101558.8719]
manager: sleeping...
Jun 05 07:39:18 hostname NetworkManager[972]: <info> [1465101558.8719] device
(wlp2s0b1): state change: activated -> unmanaged (reason 'sleeping') [100 10 37]
Jun 05 07:39:18 hostname NetworkManager[972]: <info> [1465101558.9041] dhcp4
(wlp2s0b1): canceled DHCP transaction, DHCP client pid 12403
Jun 05 07:39:18 hostname NetworkManager[972]: <info> [1465101558.9042] dhcp4
(wlp2s0b1): state changed bound -> done
Jun 05 07:39:18 hostname avahi-daemon[923]: Withdrawing address record for
fe80::7218:8bff:fe13:331d on wlp2s0b1.
Jun 05 07:39:18 hostname avahi-daemon[923]: Leaving mDNS multicast group on
interface wlp2s0b1.IPv6 with address fe80::7218:8bff:fe13:331d.
Jun 05 07:39:18 hostname kernel: brcmsmac bcma0:1: brcms_ops_bss_info_changed:
arp filtering: 0 addresses (implement)
Jun 05 07:39:18 hostname kernel: wlp2s0b1: deauthenticating from
XX:XX:XX:XX:XX:XX by local choice (Reason: 3=DEAUTH_LEAVING)
Jun 05 07:39:18 hostname avahi-daemon[923]: Interface wlp2s0b1.IPv6 no longer
relevant for mDNS.
Jun 05 07:39:18 hostname avahi-daemon[923]: Withdrawing address record for
X.X.X.X on wlp2s0b1.
Jun 05 07:39:18 hostname avahi-daemon[923]: Leaving mDNS multicast group on
interface wlp2s0b1.IPv4 with address X.X.X.X.
Jun 05 07:39:18 hostname kernel: brcmsmac bcma0:1: brcmsmac:
brcms_ops_bss_info_changed: disassociated
Jun 05 07:39:18 hostname kernel: brcmsmac bcma0:1: brcms_ops_bss_info_changed:
qos enabled: false (implement)
Jun 05 07:39:18 hostname wpa_supplicant[2555]: wlp2s0b1:
CTRL-EVENT-DISCONNECTED bssid=XX:XX:XX:XX:XX:XX reason=3 locally_generated=1
Jun 05 07:39:18 hostname avahi-daemon[923]: Interface wlp2s0b1.IPv4 no longer
relevant for mDNS.
Jun 05 07:39:18 hostname dnsmasq[4448]: setting upstream servers from DBus
Jun 05 07:39:18 hostname NetworkManager[972]: <info> [1465101558.9652]
manager: NetworkManager state is now ASLEEP
Jun 05 07:39:18 hostname kernel: IPv6: ADDRCONF(NETDEV_UP): wlp2s0b1: link is
not ready
Jun 05 07:39:19 hostname dbus[953]: [system] Activating via systemd: service
name='org.freedesktop.nm_dispatcher'
unit='dbus-org.freedesktop.nm-dispatcher.service'
Jun 05 07:39:19 hostname systemd[1]: Reached target Sleep.
Jun 05 07:39:19 hostname systemd[1]: Starting Suspend...
Jun 05 07:39:19 hostname systemd[1]: Starting Network Manager Script Dispatcher
Service...
Jun 05 07:39:19 hostname systemd-sleep[18745]: Suspending system...
Jun 05 07:39:19 hostname dbus[953]: [system] Successfully activated service
'org.freedesktop.nm_dispatcher'
Jun 05 07:39:19 hostname systemd[1]: Started Network Manager Script Dispatcher
Service.
Jun 05 07:39:19 hostname nm-dispatcher[18749]: req:1 'down' [wlp2s0b1]: new
request (5 scripts)
Jun 05 07:39:19 hostname nm-dispatcher[18749]: req:1 'down' [wlp2s0b1]: start
running ordered scripts...
Jun 05 07:39:19 hostname nm-dispatcher[18749]: Marking device and profile state
Jun 05 07:39:23 hostname kernel: PM: Syncing filesystems ... done.
Jun 05 07:39:23 hostname kernel: PM: Preparing system for sleep (mem)
Jun 05 07:39:23 hostname kernel: (NULL device *): firmware: direct-loading
firmware brcm/bcm43xx_hdr-0.fw
Jun 05 07:39:23 hostname kernel: (NULL device *): firmware: direct-loading
firmware brcm/bcm43xx-0.fw
Jun 05 07:39:23 hostname kernel: Freezing user space processes ... (elapsed
0.015 seconds) done.
Jun 05 07:39:23 hostname kernel: Freezing remaining freezable tasks ...
(elapsed 0.001 seconds) done.
Jun 05 07:39:23 hostname kernel: PM: Suspending system (mem)
Jun 05 07:39:23 hostname kernel: Suspending console(s) (use no_console_suspend
to debug)
Jun 05 07:39:23 hostname kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Jun 05 07:39:23 hostname kernel: sd 0:0:0:0: [sda] Stopping disk
Jun 05 07:39:23 hostname kernel: e1000e: EEE TX LPI TIMER: 00000011
Jun 05 07:39:23 hostname kernel: PM: suspend of devices complete after 347.483
msecs
Jun 05 07:39:23 hostname kernel: PM: late suspend of devices complete after
15.394 msecs
Jun 05 07:39:23 hostname kernel: ehci-pci 0000:00:1d.0: System wakeup enabled
by ACPI
Jun 05 07:39:23 hostname kernel: ehci-pci 0000:00:1a.0: System wakeup enabled
by ACPI
Jun 05 07:39:23 hostname kernel: e1000e 0000:00:19.0: System wakeup enabled by
ACPI
Jun 05 07:39:23 hostname kernel: xhci_hcd 0000:00:14.0: System wakeup enabled
by ACPI
Jun 05 07:39:23 hostname kernel: PM: noirq suspend of devices complete after
17.699 msecs
Jun 05 07:39:23 hostname kernel: ACPI: Preparing to enter system sleep state S3
Jun 05 07:39:23 hostname kernel: ACPI : EC: EC stopped
Jun 05 07:39:23 hostname kernel: PM: Saving platform NVS memory
Jun 05 07:39:23 hostname kernel: Disabling non-boot CPUs ...
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 28
Jun 05 07:39:23 hostname kernel: smpboot: CPU 1 is now offline
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 16
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 17
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 21
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 27
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 28
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 31
Jun 05 07:39:23 hostname kernel: smpboot: CPU 2 is now offline
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 1
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 8
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 9
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 12
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 16
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 17
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 21
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 23
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 27
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 28
Jun 05 07:39:23 hostname kernel: Broke affinity for irq 31
Jun 05 07:39:23 hostname kernel: smpboot: CPU 3 is now offline
Jun 05 07:39:23 hostname kernel: ACPI: Low-level resume complete
Jun 05 07:39:23 hostname kernel: ACPI : EC: EC started
Jun 05 07:39:23 hostname kernel: PM: Restoring platform NVS memory
Jun 05 07:39:23 hostname kernel: microcode: CPU0 microcode updated early to
revision 0x1c, date = 2015-02-26
Jun 05 07:39:23 hostname kernel: Enabling non-boot CPUs ...
Jun 05 07:39:23 hostname kernel: x86: Booting SMP configuration:
Jun 05 07:39:23 hostname kernel: smpboot: Booting Node 0 Processor 1 APIC 0x2
Jun 05 07:39:23 hostname kernel: microcode: CPU1 microcode updated early to
revision 0x1c, date = 2015-02-26
Jun 05 07:39:23 hostname kernel: cache: parent cpu1 should not be sleeping
Jun 05 07:39:23 hostname kernel: CPU1 is up
Jun 05 07:39:23 hostname kernel: smpboot: Booting Node 0 Processor 2 APIC 0x1
Jun 05 07:39:23 hostname kernel: cache: parent cpu2 should not be sleeping
Jun 05 07:39:23 hostname kernel: CPU2 is up
Jun 05 07:39:23 hostname kernel: smpboot: Booting Node 0 Processor 3 APIC 0x3
Jun 05 07:39:23 hostname kernel: cache: parent cpu3 should not be sleeping
Jun 05 07:39:23 hostname kernel: CPU3 is up
Jun 05 07:39:23 hostname kernel: ACPI: Waking up from system sleep state S3
Jun 05 07:39:23 hostname kernel: ehci-pci 0000:00:1a.0: System wakeup disabled
by ACPI
Jun 05 07:39:23 hostname kernel: ehci-pci 0000:00:1d.0: System wakeup disabled
by ACPI
Jun 05 07:39:23 hostname kernel: xhci_hcd 0000:00:14.0: System wakeup disabled
by ACPI
Jun 05 07:39:23 hostname kernel: PM: noirq resume of devices complete after
16.516 msecs
Jun 05 07:39:23 hostname kernel: PM: early resume of devices complete after
0.370 msecs
Jun 05 07:39:23 hostname kernel: sd 0:0:0:0: [sda] Starting disk
Jun 05 07:39:23 hostname kernel: e1000e 0000:00:19.0: System wakeup disabled by
ACPI
Jun 05 07:39:23 hostname kernel: rtc_cmos 00:02: System wakeup disabled by ACPI
Jun 05 07:39:23 hostname kernel: ata6: SATA link down (SStatus 0 SControl 300)
Jun 05 07:39:23 hostname kernel: ata5: SATA link down (SStatus 0 SControl 300)
Jun 05 07:39:23 hostname kernel: ata2: SATA link up 1.5 Gbps (SStatus 113
SControl 300)
Jun 05 07:39:23 hostname kernel: ata2.00: configured for UDMA/100
Jun 05 07:39:23 hostname kernel: PM: resume of devices complete after 519.314
msecs
Jun 05 07:39:23 hostname kernel: PM: Finishing wakeup.
Jun 05 07:39:23 hostname kernel: Restarting tasks ... done.
Jun 05 07:39:23 hostname systemd[1]: Time has been changed
Jun 05 07:39:23 hostname systemd[1]: apt-daily.timer: Adding 5h 46min
42.569185s random time.
Jun 05 07:39:23 hostname systemd[4571]: Time has been changed
Jun 05 07:39:23 hostname kasper-net-tweaks[18866]: doing nothing
Jun 05 07:39:24 hostname kernel: ata1: SATA link up 6.0 Gbps (SStatus 133
SControl 300)
Jun 05 07:39:24 hostname kernel: ata1.00: ACPI cmd ef/10:06:00:00:00:00 (SET
FEATURES) succeeded
Jun 05 07:39:24 hostname kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:00
(SECURITY FREEZE LOCK) filtered out
Jun 05 07:39:24 hostname kernel: ata1.00: ACPI cmd b1/c1:00:00:00:00:00 (DEVICE
CONFIGURATION OVERLAY) filtered out
Jun 05 07:39:24 hostname kernel: ata1.00: ACPI cmd 00/00:00:00:00:00:a0 (NOP)
rejected by device (Stat=0x51 Err=0x04)
Jun 05 07:39:24 hostname kernel: ata1.00: supports DRM functions and may not be
fully accessible
Jun 05 07:39:24 hostname kernel: ata1.00: disabling queued TRIM support
Jun 05 07:39:24 hostname kernel: ata1.00: ACPI cmd ef/10:06:00:00:00:00 (SET
FEATURES) succeeded
Jun 05 07:39:24 hostname kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:00
(SECURITY FREEZE LOCK) filtered out
Jun 05 07:39:24 hostname kernel: ata1.00: ACPI cmd b1/c1:00:00:00:00:00 (DEVICE
CONFIGURATION OVERLAY) filtered out
Jun 05 07:39:24 hostname kernel: ata1.00: ACPI cmd 00/00:00:00:00:00:a0 (NOP)
rejected by device (Stat=0x51 Err=0x04)
Jun 05 07:39:24 hostname kernel: ata1.00: supports DRM functions and may not be
fully accessible
Jun 05 07:39:24 hostname kernel: ata1.00: disabling queued TRIM support
Jun 05 07:39:24 hostname kernel: ata1.00: configured for UDMA/133
Jun 05 07:39:24 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:24 hostname kernel: ata1.00: Enabling discard_zeroes_data
Jun 05 07:39:24 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:24 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:24 hostname kernel: pci_bus 0000:01: Allocating resources
Jun 05 07:39:24 hostname kernel: pci_bus 0000:02: Allocating resources
Jun 05 07:39:24 hostname kernel: pci_bus 0000:03: Allocating resources
Jun 05 07:39:24 hostname kernel: pci_bus 0000:07: Allocating resources
Jun 05 07:39:24 hostname kernel: pci_bus 0000:0b: Allocating resources
Jun 05 07:39:24 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:24 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:24 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:24 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:24 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:24 hostname kernel: acpi PNP0401:00: Already enumerated
Jun 05 07:39:24 hostname ntpd[1138]: Deleting interface #17 wlp2s0b1,
X.X.X.X#123, interface stats: received=62, sent=62, dropped=0, active_time=666
secs
Jun 05 07:39:24 hostname ntpd[1138]: X.X.X.X local addr X.X.X.X -> <null>
Jun 05 07:39:24 hostname ntpd[1138]: X.X.X.X local addr X.X.X.X -> <null>
Jun 05 07:39:24 hostname ntpd[1138]: X.X.X.X local addr X.X.X.X -> <null>
Jun 05 07:39:24 hostname ntpd[1138]: X.X.X.X local addr X.X.X.X -> <null>
Jun 05 07:39:24 hostname ntpd[1138]: X.X.X.X local addr X.X.X.X -> <null>
Jun 05 07:39:24 hostname ntpd[1138]: X.X.X.X local addr X.X.X.X -> <null>
Jun 05 07:39:24 hostname ntpd[1138]: X.X.X.X local addr X.X.X.X -> <null>
Jun 05 07:39:24 hostname ntpd[1138]: X.X.X.X local addr X.X.X.X -> <null>
Jun 05 07:39:24 hostname ntpd[1138]: Deleting interface #18 wlp2s0b1,
fe80::7218:8bff:fe13:331d%3#123, interface stats: received=0, sent=0,
dropped=0, active_time=666 secs
Jun 05 07:39:24 hostname kernel: acpi PNP0501:00: Still not present
Jun 05 07:39:24 hostname systemd-sleep[18745]: System resumed.
Jun 05 07:39:24 hostname systemd-sleep[18745]: /dev/sda:
Jun 05 07:39:24 hostname systemd-sleep[18745]: setting Advanced Power
Management level to 0xfe (254)
Jun 05 07:39:24 hostname systemd-sleep[18745]: APM_level = 254
Jun 05 07:39:24 hostname systemd[1]: Started Suspend.
Jun 05 07:39:24 hostname systemd[1]: sleep.target: Unit not needed anymore.
Stopping.
Jun 05 07:39:24 hostname systemd[1]: Stopped target Sleep.
Jun 05 07:39:24 hostname systemd[1]: Reached target Suspend.
Jun 05 07:39:24 hostname systemd[1]: suspend.target: Unit is bound to inactive
unit systemd-suspend.service. Stopping, too.
Jun 05 07:39:24 hostname systemd[1]: Stopped target Suspend.
Jun 05 07:39:24 hostname systemd-logind[899]: Operation 'sleep' finished.
Jun 05 07:39:24 hostname NetworkManager[972]: <info> [1465101564.2325]
manager: wake requested (sleeping: yes enabled: yes)
Jun 05 07:39:24 hostname NetworkManager[972]: <info> [1465101564.2326]
manager: waking up...
Jun 05 07:39:24 hostname NetworkManager[972]: <info> [1465101564.2326] device
(eno1): state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37]
Jun 05 07:39:24 hostname systemd[1]: Started Run anacron jobs at resume.
Jun 05 07:39:24 hostname systemd[1]: Started Run anacron jobs.
Jun 05 07:39:24 hostname anacron[18911]: Anacron 2.3 started on 2016-06-05
Jun 05 07:39:24 hostname anacron[18911]: Normal exit (0 jobs run)
Jun 05 07:39:24 hostname NetworkManager[972]: <info> [1465101564.3729] device
(eno1): state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Jun 05 07:39:24 hostname kernel: e1000e: eno1 NIC Link is Down
Jun 05 07:39:24 hostname kernel: IPv6: ADDRCONF(NETDEV_UP): eno1: link is not
ready
Jun 05 07:39:24 hostname NetworkManager[972]: <info> [1465101564.6286] device
(wlp2s0b1): state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Jun 05 07:39:24 hostname kernel: IPv6: ADDRCONF(NETDEV_UP): eno1: link is not
ready
Jun 05 07:39:24 hostname kernel: IPv6: ADDRCONF(NETDEV_UP): wlp2s0b1: link is
not ready
Jun 05 07:39:24 hostname NetworkManager[972]: <info> [1465101564.8053]
manager: NetworkManager state is now DISCONNECTED
Jun 05 07:39:24 hostname kernel: brcmsmac bcma0:1: brcms_ops_bss_info_changed:
qos enabled: false (implement)
Jun 05 07:39:24 hostname kernel: brcmsmac bcma0:1: brcms_ops_config: change
power-save mode: false (implement)
Jun 05 07:39:24 hostname kernel: IPv6: ADDRCONF(NETDEV_UP): wlp2s0b1: link is
not ready
Jun 05 07:39:24 hostname NetworkManager[972]: <info> [1465101564.8466]
sup-iface[0x24c6f80,wlp2s0b1]: supports 4 scan SSIDs
Jun 05 07:39:24 hostname NetworkManager[972]: <info> [1465101564.8473] device
(wlp2s0b1): supplicant interface state: starting -> ready
Jun 05 07:39:24 hostname NetworkManager[972]: <info> [1465101564.8474] device
(wlp2s0b1): state change: unavailable -> disconnected (reason
'supplicant-available') [20 30 42]
Jun 05 07:39:24 hostname kernel: IPv6: ADDRCONF(NETDEV_UP): wlp2s0b1: link is
not ready
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6836] device
(wlp2s0b1): supplicant interface state: ready -> inactive
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6846] policy:
auto-activating connection 'wlanssid'
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6855] device
(wlp2s0b1): Activation: starting connection 'wlanssid'
(86cc34b6-46a0-4211-8aed-454e6481fd74)
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6856] device
(wlp2s0b1): state change: disconnected -> prepare (reason 'none') [30 40 0]
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6857]
manager: NetworkManager state is now CONNECTING
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6861] device
(wlp2s0b1): state change: prepare -> config (reason 'none') [40 50 0]
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6863] device
(wlp2s0b1): Activation: (wifi) access point 'wlanssid' has security, but
secrets are required.
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6863] device
(wlp2s0b1): state change: config -> need-auth (reason 'none') [50 60 0]
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6890] device
(wlp2s0b1): state change: need-auth -> prepare (reason 'none') [60 40 0]
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6894] device
(wlp2s0b1): state change: prepare -> config (reason 'none') [40 50 0]
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6896] device
(wlp2s0b1): Activation: (wifi) connection 'wlanssid' has security, and secrets
exist. No new secrets needed.
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6896] Config:
added 'ssid' value 'wlanssid'
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6896] Config:
added 'scan_ssid' value '1'
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6896] Config:
added 'key_mgmt' value 'WPA-PSK'
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6896] Config:
added 'psk' value '<omitted>'
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.6935]
sup-iface[0x24c6f80,wlp2s0b1]: config: set interface ap_scan to 1
Jun 05 07:39:25 hostname wpa_supplicant[2555]: wlp2s0b1: SME: Trying to
authenticate with XX:XX:XX:XX:XX:XX (SSID='wlanssid' freq=2412 MHz)
Jun 05 07:39:25 hostname wpa_supplicant[2555]: wlp2s0b1: Trying to associate
with XX:XX:XX:XX:XX:XX (SSID='wlanssid' freq=2412 MHz)
Jun 05 07:39:25 hostname kernel: wlp2s0b1: authenticate with XX:XX:XX:XX:XX:XX
Jun 05 07:39:25 hostname kernel: wlp2s0b1: send auth to XX:XX:XX:XX:XX:XX (try
1/3)
Jun 05 07:39:25 hostname kernel: wlp2s0b1: authenticated
Jun 05 07:39:25 hostname kernel: wlp2s0b1: associate with XX:XX:XX:XX:XX:XX
(try 1/3)
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7056] device
(wlp2s0b1): supplicant interface state: inactive -> associating
Jun 05 07:39:25 hostname kernel: wlp2s0b1: RX AssocResp from XX:XX:XX:XX:XX:XX
(capab=0x411 status=0 aid=1)
Jun 05 07:39:25 hostname wpa_supplicant[2555]: wlp2s0b1: Associated with
XX:XX:XX:XX:XX:XX
Jun 05 07:39:25 hostname kernel: brcmsmac bcma0:1: brcmsmac:
brcms_ops_bss_info_changed: associated
Jun 05 07:39:25 hostname kernel: brcmsmac bcma0:1: brcms_ops_bss_info_changed:
qos enabled: true (implement)
Jun 05 07:39:25 hostname kernel: wlp2s0b1: associated
Jun 05 07:39:25 hostname kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlp2s0b1: link
becomes ready
Jun 05 07:39:25 hostname kernel: brcmsmac bcma0:1: wl0:
brcms_c_d11hdrs_mac80211: txop exceeded phylen 159/256 dur 1778/1472
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7133] device
(wlp2s0b1): supplicant interface state: associating -> 4-way handshake
Jun 05 07:39:25 hostname wpa_supplicant[2555]: wlp2s0b1: WPA: Key negotiation
completed with XX:XX:XX:XX:XX:XX [PTK=CCMP GTK=TKIP]
Jun 05 07:39:25 hostname wpa_supplicant[2555]: wlp2s0b1: CTRL-EVENT-CONNECTED -
Connection to XX:XX:XX:XX:XX:XX completed [id=0 id_str=]
Jun 05 07:39:25 hostname kernel: brcmsmac bcma0:1: wl0:
brcms_c_d11hdrs_mac80211: txop exceeded phylen 137/256 dur 1602/1472
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7198] device
(wlp2s0b1): supplicant interface state: 4-way handshake -> completed
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7198] device
(wlp2s0b1): Activation: (wifi) Stage 2 of 5 (Device Configure) successful.
Connected to wireless network 'wlanssid'.
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7199] device
(wlp2s0b1): state change: config -> ip-config (reason 'none') [50 70 0]
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7202] dhcp4
(wlp2s0b1): activation: beginning transaction (timeout in 45 seconds)
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7215] dhcp4
(wlp2s0b1): dhclient started with pid 19015
Jun 05 07:39:25 hostname dhclient[19015]: DHCPREQUEST of X.X.X.X on wlp2s0b1 to
X.X.X.X port 67
Jun 05 07:39:25 hostname dhclient[19015]: DHCPACK of X.X.X.X from X.X.X.X
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7852]
address X.X.X.X
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7852] plen
24 (X.X.X.X)
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7852]
gateway X.X.X.X
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7852]
server identifier X.X.X.X
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7852] lease
time 259200
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7853]
hostname 'hostname'
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7853]
nameserver 'X.X.X.X'
Jun 05 07:39:25 hostname avahi-daemon[923]: Joining mDNS multicast group on
interface wlp2s0b1.IPv4 with address X.X.X.X.
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7853]
domain name 'spacelair'
Jun 05 07:39:25 hostname avahi-daemon[923]: New relevant interface
wlp2s0b1.IPv4 for mDNS.
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7853]
domain search 'spacelair.'
Jun 05 07:39:25 hostname avahi-daemon[923]: Registering new address record for
X.X.X.X on wlp2s0b1.IPv4.
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7853]
domain search 'bugville.'
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7853]
domain search 'brickhouse.'
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7853] dhcp4
(wlp2s0b1): state changed unknown -> bound
Jun 05 07:39:25 hostname kernel: brcmsmac bcma0:1: brcms_ops_bss_info_changed:
arp filtering: 1 addresses (implement)
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7867] device
(wlp2s0b1): state change: ip-config -> ip-check (reason 'none') [70 80 0]
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7871] device
(wlp2s0b1): state change: ip-check -> secondaries (reason 'none') [80 90 0]
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7874] device
(wlp2s0b1): state change: secondaries -> activated (reason 'none') [90 100 0]
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.7876]
manager: NetworkManager state is now CONNECTED_LOCAL
Jun 05 07:39:25 hostname dhclient[19015]: bound to X.X.X.X -- renewal in 98548
seconds.
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.8060]
manager: NetworkManager state is now CONNECTED_GLOBAL
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.8061] policy:
set 'wlanssid' (wlp2s0b1) as default for IPv4 routing and DNS
Jun 05 07:39:25 hostname NetworkManager[972]: <info> [1465101565.8063] device
(wlp2s0b1): Activation: successful, device activated.
Jun 05 07:39:25 hostname dnsmasq[4448]: setting upstream servers from DBus
Jun 05 07:39:25 hostname dnsmasq[4448]: using nameserver X.X.X.X#53
Jun 05 07:39:25 hostname nm-dispatcher[18749]: req:2 'up' [wlp2s0b1]: new
request (5 scripts)
Jun 05 07:39:25 hostname nm-dispatcher[18749]: req:2 'up' [wlp2s0b1]: start
running ordered scripts...
Jun 05 07:39:25 hostname nm-dispatcher[18749]: Marking device and profile state
Jun 05 07:39:25 hostname org.freedesktop.Notifications[4620]: Could not load
icon: 'nm-signal-75'
Jun 05 07:39:25 hostname org.freedesktop.Notifications[4620]: Could not load
icon: 'nm-signal-75'
Jun 05 07:39:25 hostname systemd[1]: Reloading OpenBSD Secure Shell server.
Jun 05 07:39:25 hostname sshd[984]: Received SIGHUP; restarting.
Jun 05 07:39:25 hostname systemd[1]: Reloaded OpenBSD Secure Shell server.
Jun 05 07:39:25 hostname sshd[984]: Server listening on X.X.X.X port 12323.
Jun 05 07:39:25 hostname sshd[984]: Server listening on :: port 12323.
Jun 05 07:39:25 hostname kasper-net-tweaks[19138]: doing nothing
Jun 05 07:39:27 hostname ntpd[1138]: Listen normally on 19 wlp2s0b1 X.X.X.X:123
Jun 05 07:39:27 hostname ntpd[1138]: bind(24) AF_INET6
fe80::7218:8bff:fe13:331d%3#123 flags 0x11 failed: Cannot assign requested
address
Jun 05 07:39:27 hostname ntpd[1138]: unable to create socket on wlp2s0b1 (20)
for fe80::7218:8bff:fe13:331d%3#123
Jun 05 07:39:27 hostname ntpd[1138]: failed to init interface for address
fe80::7218:8bff:fe13:331d%3
Jun 05 07:39:27 hostname avahi-daemon[923]: Joining mDNS multicast group on
interface wlp2s0b1.IPv6 with address fe80::7218:8bff:fe13:331d.
Jun 05 07:39:27 hostname avahi-daemon[923]: New relevant interface
wlp2s0b1.IPv6 for mDNS.
Jun 05 07:39:27 hostname avahi-daemon[923]: Registering new address record for
fe80::7218:8bff:fe13:331d on wlp2s0b1.*.
Jun 05 07:39:29 hostname ntpd[1138]: Listen normally on 21 wlp2s0b1
[fe80::7218:8bff:fe13:331d%3]:123
Jun 05 07:39:29 hostname systemd-logind[899]: Lid opened.
Jun 05 07:39:29 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:29 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:29 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:29 hostname kernel: pci_bus 0000:01: Allocating resources
Jun 05 07:39:29 hostname kernel: pci_bus 0000:02: Allocating resources
Jun 05 07:39:29 hostname kernel: pci_bus 0000:03: Allocating resources
Jun 05 07:39:29 hostname kernel: pci_bus 0000:07: Allocating resources
Jun 05 07:39:29 hostname kernel: pci_bus 0000:0b: Allocating resources
Jun 05 07:39:29 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:29 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:29 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:29 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:29 hostname kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000
flags 0x2] has bogus alignment
Jun 05 07:39:30 hostname wpa_supplicant[2555]: wlp2s0b1:
CTRL-EVENT-REGDOM-CHANGE init=BEACON_HINT type=UNKNOWN
Jun 05 07:39:32 hostname ntpd[1138]: X.X.X.X local addr X.X.X.X -> <null>
################################
-- System Information:
Debian Release: stretch/sid
APT prefers testing
APT policy: (900, 'testing'), (400, 'unstable'), (300, 'experimental')
Architecture: amd64 (x86_64)
Foreign Architectures: i386
Kernel: Linux 4.5.0-2-amd64 (SMP w/4 CPU cores)
Locale: LANG=ru_RU.UTF-8, LC_CTYPE=ru_RU.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash
Init: systemd (via /run/systemd/system)
--- End Message ---
--- Begin Message ---
Hi
This bug was filed for a very old kernel or the bug is old itself
without resolution.
If you can reproduce it with
- the current version in unstable/testing
- the latest kernel from backports
please reopen the bug, see https://www.debian.org/Bugs/server-control
for details.
Regards,
Salvatore
--- End Message ---
