Arch Linux

jwhendy

Member

Registered: 2010-04-01

Posts: 621

Laptop resumes to terminal screen with pciehp hot-add error, frozen

The last two times I've suspended my laptop to RAM (lid close), it fails to fully resume, giving me only the following on a terminal-like screen instead of resuming to the window manager:

Dec 31 22:56:23 arch_zbook kernel: pciehp 0000:3d:03.0:pcie24: Cannot add device at 0000:60:00
Dec 31 22:56:23 arch_zbook kernel: pciehp 0000:3d:03.0:pcie24: Device 0000:60:00.0 already exists at 0000:60:00, cannot hot-add
Dec 31 22:56:23 arch_zbook kernel: pciehp 0000:3d:03.0:pcie24: Cannot add device at 0000:60:00
Dec 31 22:56:23 arch_zbook kernel: pciehp 0000:3d:03.0:pcie24: Device 0000:60:00.0 already exists at 0000:60:00, cannot hot-add

I can't get off of that screen. ctrl+alt+del does nothing (but I don't have it defined as anything either), I tried my keyboard shortcut for my openbox menu and choosing log out without success, ctrl+alt+fn[2-9] doesn't get me to a different tty... I just have to press the power button to manually kill it and then boot up again.

There's a somewhat similar post here which points to a ~2 year old bug report here. I don't think these are identical, as 1) no one has posted a confirmation of the behavior since 3.18, and 2) the author only mentions it showing in his log vs. a resume freeze.

Some system info:

$ uname -a
Linux host_name 4.2.5-1-ARCH #1 SMP PREEMPT Tue Oct 27 08:13:28 CET 2015 x86_64 GNU/Linu


$ lspci
00:00.0 Host bridge: Intel Corporation Xeon E3-1200 v3/4th Gen Core Processor DRAM Controller (rev 06)
00:01.0 PCI bridge: Intel Corporation Xeon E3-1200 v3/4th Gen Core Processor PCI Express x16 Controller (rev 06)
00:02.0 VGA compatible controller: Intel Corporation 4th Gen Core Processor Integrated Graphics Controller (rev 06)
00:14.0 USB controller: Intel Corporation 8 Series/C220 Series Chipset Family USB xHCI (rev 04)
00:16.0 Communication controller: Intel Corporation 8 Series/C220 Series Chipset Family MEI Controller #1 (rev 04)
00:16.3 Serial controller: Intel Corporation 8 Series/C220 Series Chipset Family KT Controller (rev 04)
00:19.0 Ethernet controller: Intel Corporation Ethernet Connection I217-LM (rev 04)
00:1a.0 USB controller: Intel Corporation 8 Series/C220 Series Chipset Family USB EHCI #2 (rev 04)
00:1b.0 Audio device: Intel Corporation 8 Series/C220 Series Chipset High Definition Audio Controller (rev 04)
00:1c.0 PCI bridge: Intel Corporation 8 Series/C220 Series Chipset Family PCI Express Root Port #1 (rev d4)
00:1c.4 PCI bridge: Intel Corporation 8 Series/C220 Series Chipset Family PCI Express Root Port #5 (rev d4)
00:1c.6 PCI bridge: Intel Corporation 8 Series/C220 Series Chipset Family PCI Express Root Port #7 (rev d4)
00:1d.0 USB controller: Intel Corporation 8 Series/C220 Series Chipset Family USB EHCI #1 (rev 04)
00:1f.0 ISA bridge: Intel Corporation QM87 Express LPC Controller (rev 04)
00:1f.2 SATA controller: Intel Corporation 8 Series/C220 Series Chipset Family 6-port SATA Controller 1 [AHCI mode] (rev 04)
00:1f.3 SMBus: Intel Corporation 8 Series/C220 Series Chipset Family SMBus Controller (rev 04)
01:00.0 VGA compatible controller: NVIDIA Corporation GK106GLM [Quadro K2100M] (rev a1)
01:00.1 Audio device: NVIDIA Corporation GK106 HDMI Audio Controller (rev a1)
3b:00.0 SATA controller: Marvell Technology Group Ltd. 88SS9183 PCIe SSD Controller (rev 14)
3c:00.0 PCI bridge: Pericom Semiconductor Device 2404 (rev 05)
3d:01.0 PCI bridge: Pericom Semiconductor Device 2404 (rev 05)
3d:02.0 PCI bridge: Pericom Semiconductor Device 2404 (rev 05)
3d:03.0 PCI bridge: Pericom Semiconductor Device 2404 (rev 05)
3e:00.0 Network controller: Intel Corporation Wireless 7260 (rev 6b)
60:00.0 Unassigned class [ff00]: Realtek Semiconductor Co., Ltd. RTS5249 PCI Express Card Reader (rev 01)


$ lsmod
Module                  Size  Used by
uinput                 20480  0
cmac                   16384  0
ecb                    16384  0
rfcomm                 61440  0
bnep                   20480  2
btrtl                  16384  0
btbcm                  16384  0
btintel                16384  0
bluetooth             446464  11 bnep,btbcm,btrtl,rfcomm,btintel
ctr                    16384  3
ccm                    20480  3
fuse                   90112  3
joydev                 20480  0
mousedev               20480  0
ax25                   61440  0
snd_hda_codec_hdmi     49152  1
arc4                   16384  2
tpm_infineon           20480  0
snd_hda_codec_realtek    73728  1
snd_hda_codec_generic    69632  1 snd_hda_codec_realtek
iTCO_wdt               16384  0
iTCO_vendor_support    16384  1 iTCO_wdt
ppdev                  20480  0
hp_wmi                 16384  0
sparse_keymap          16384  1 hp_wmi
mxm_wmi                16384  0
iwlmvm                229376  0
mac80211              651264  1 iwlmvm
intel_rapl             20480  0
iosf_mbi               16384  1 intel_rapl
x86_pkg_temp_thermal    16384  0
intel_powerclamp       16384  0
coretemp               16384  0
kvm_intel             163840  0
iwlwifi               172032  1 iwlmvm
snd_hda_intel          32768  5
kvm                   446464  1 kvm_intel
snd_hda_codec         106496  4 snd_hda_codec_realtek,snd_hda_codec_hdmi,snd_hda_codec_generic,snd_hda_intel
cfg80211              466944  3 iwlwifi,mac80211,iwlmvm
snd_hda_core           49152  5 snd_hda_codec_realtek,snd_hda_codec_hdmi,snd_hda_codec_generic,snd_hda_codec,snd_hda_intel
snd_hwdep              16384  1 snd_hda_codec
pcspkr                 16384  0
rtsx_pci_ms            20480  0
rfkill                 20480  6 cfg80211,hp_wmi,bluetooth
snd_pcm                86016  4 snd_hda_codec_hdmi,snd_hda_codec,snd_hda_intel,snd_hda_core
memstick               16384  1 rtsx_pci_ms
psmouse               118784  0
input_leds             16384  0
e1000e                217088  0
snd_timer              28672  1 snd_pcm
snd                    65536  18 snd_hda_codec_realtek,snd_hwdep,snd_timer,snd_hda_codec_hdmi,snd_pcm,snd_hda_codec_generic,snd_hda_codec,snd_hda_intel
serio_raw              16384  0
i2c_i801               20480  0
soundcore              16384  1 snd
hp_accel               28672  0
ie31200_edac           16384  0
lpc_ich                24576  0
ptp                    20480  1 e1000e
parport_pc             28672  0
edac_core              45056  1 ie31200_edac
mei_me                 24576  0
led_class              16384  3 hp_accel,iwlmvm,input_leds
parport                40960  2 ppdev,parport_pc
pps_core               20480  1 ptp
shpchp                 32768  0
mei                    77824  1 mei_me
lis3lv02d              20480  1 hp_accel
thermal                20480  0
input_polldev          16384  1 lis3lv02d
tpm_tis                20480  0
wmi                    20480  2 hp_wmi,mxm_wmi
evdev                  24576  27
hp_wireless            16384  0
tpm                    32768  2 tpm_tis,tpm_infineon
mac_hid                16384  0
ac                     16384  0
battery                20480  0
processor              32768  0
sch_fq_codel           20480  6
ip_tables              28672  0
x_tables               28672  1 ip_tables
ext4                  507904  1
crc16                  16384  2 ext4,bluetooth
mbcache                20480  1 ext4
jbd2                   90112  1 ext4
sha256_ssse3           28672  1
sha256_generic         24576  1 sha256_ssse3
hmac                   16384  1
drbg                   32768  1
ansi_cprng             16384  0
algif_skcipher         20480  0
af_alg                 16384  1 algif_skcipher
dm_crypt               28672  1
dm_mod                102400  3 dm_crypt
sd_mod                 36864  2
uas                    24576  0
usb_storage            61440  1 uas
rtsx_pci_sdmmc         24576  0
mmc_core              110592  1 rtsx_pci_sdmmc
atkbd                  24576  0
libps2                 16384  2 atkbd,psmouse
crct10dif_pclmul       16384  0
crc32_pclmul           16384  0
crc32c_intel           24576  0
aesni_intel           167936  8
aes_x86_64             20480  1 aesni_intel
lrw                    16384  1 aesni_intel
gf128mul               16384  1 lrw
glue_helper            16384  1 aesni_intel
ablk_helper            16384  1 aesni_intel
cryptd                 20480  3 aesni_intel,ablk_helper
ahci                   36864  1
libahci                28672  1 ahci
libata                196608  2 ahci,libahci
rtsx_pci               45056  2 rtsx_pci_ms,rtsx_pci_sdmmc
xhci_pci               16384  0
ehci_pci               16384  0
xhci_hcd              155648  1 xhci_pci
ehci_hcd               69632  1 ehci_pci
scsi_mod              147456  4 uas,usb_storage,libata,sd_mod
usbcore               196608  6 uas,usb_storage,ehci_hcd,ehci_pci,xhci_hcd,xhci_pci
usb_common             16384  1 usbcore
i8042                  24576  2 hp_accel,libps2
serio                  20480  10 serio_raw,atkbd,i8042,hp_accel,psmouse
i915                 1056768  3
video                  32768  1 i915
button                 16384  1 i915
i2c_algo_bit           16384  1 i915
drm_kms_helper        102400  1 i915
intel_agp              20480  0
intel_gtt              20480  2 i915,intel_agp
nvidia               8708096  1
drm                   286720  7 i915,drm_kms_helper,nvidia


# last two days of pacman upgrades; nothing looks suspicious?
[2015-12-29 10:37] [PACMAN] Running 'pacman -Syu'
[2015-12-29 10:37] [PACMAN] synchronizing package lists
[2015-12-29 10:37] [PACMAN] starting full system upgrade
[2015-12-29 10:39] [ALPM] transaction started
[2015-12-29 10:39] [ALPM] installed pugixml (1.7-2)
[2015-12-29 10:39] [ALPM] installed osm-gps-map-gtk3 (1.1.0-2)
[2015-12-29 10:39] [ALPM] installed colord-gtk (0.1.26-2)
[2015-12-29 10:39] [ALPM] installed graphicsmagick (1.3.23-2)
[2015-12-29 10:39] [ALPM] upgraded darktable (1.6.9-2 -> 2.0.0-4)
[2015-12-29 10:39] [ALPM] upgraded rsync (3.1.1-4 -> 3.1.2-1)
[2015-12-29 10:39] [ALPM] upgraded syncthing (0.12.9-1 -> 0.12.10-1)
[2015-12-29 10:39] [ALPM] upgraded wpa_supplicant (1:2.5-1 -> 1:2.5-2)
[2015-12-29 10:39] [ALPM] transaction completed
[2015-12-29 18:55] [PACMAN] Running 'pacman --color auto -Sy'
[2015-12-29 18:55] [PACMAN] synchronizing package lists

[2015-12-29 18:57] [PACMAN] Running 'pacman -Syu'
[2015-12-29 18:57] [PACMAN] synchronizing package lists
[2015-12-29 18:57] [PACMAN] starting full system upgrade
[2015-12-29 19:04] [ALPM] transaction started
[2015-12-29 19:04] [ALPM] upgraded p11-kit (0.23.1-3 -> 0.23.2-1)
[2015-12-29 19:04] [ALPM] upgraded ca-certificates-mozilla (3.20.1-1 -> 3.21-1)
[2015-12-29 19:04] [ALPM] upgraded libwebp (0.4.4-1 -> 0.5.0-1)
[2015-12-29 19:04] [ALPM] upgraded ffmpeg (1:2.8.4-1 -> 1:2.8.4-2)
[2015-12-29 19:04] [ALPM] upgraded imagemagick (6.9.2.6-3 -> 6.9.2.10-1)
[2015-12-29 19:04] [ALPM] upgraded nspr (4.10.10-1 -> 4.11-1)
[2015-12-29 19:04] [ALPM] upgraded nss (3.20.1-1 -> 3.21-1)
[2015-12-29 19:04] [ALPM] upgraded webkitgtk (2.4.9-4 -> 2.4.9-5)
[2015-12-29 19:04] [ALPM] transaction completed

Are there any methods I could use to track down the issue? This is a huge hindrance to normal laptop usage, especially since I use this at work. In case it helps, here's a full suspend/resume cycle, or at least I think it should be. I went from "lid closed" through the failed resume, stopping at when I manually hard killed it with the power button. Note this is with journalctl -r, so it starts with the most recent messages at the top.

Dec 31 22:56:35 arch_zbook root[18759]: PowerButton pressed
Dec 31 22:56:35 arch_zbook systemd-logind[444]: System is powering down.
Dec 31 22:56:35 arch_zbook systemd-logind[444]: Powering Off...
Dec 31 22:56:35 arch_zbook systemd-logind[444]: Power key pressed.
Dec 31 22:56:35 arch_zbook kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlp62s0: link becomes ready
Dec 31 22:56:35 arch_zbook kernel: wlp62s0: associated
Dec 31 22:56:35 arch_zbook kernel: wlp62s0: RX AssocResp from 00:26:88:e0:30:a0 (capab=0x411 status=0 aid=2)
Dec 31 22:56:35 arch_zbook kernel: wlp62s0: associate with 00:26:88:e0:30:a0 (try 1/3)
Dec 31 22:56:35 arch_zbook kernel: wlp62s0: authenticated
Dec 31 22:56:35 arch_zbook kernel: wlp62s0: send auth to 00:26:88:e0:30:a0 (try 1/3)
Dec 31 22:56:35 arch_zbook kernel: wlp62s0: authenticate with 00:26:88:e0:30:a0
Dec 31 22:56:33 arch_zbook wicd[445]: SET failed on device %s ; No such device.
Dec 31 22:56:33 arch_zbook wicd[445]: Error for wireless request "Set Bit Rate" (8B20) :
Dec 31 22:56:33 arch_zbook wicd[445]: Failed to connect to non-global ctrl_ifname: wlp62s0  error: No such file or directory
Dec 31 22:56:33 arch_zbook kernel: IPv6: ADDRCONF(NETDEV_UP): wlp62s0: link is not ready
Dec 31 22:56:33 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:33 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:33 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:33 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:33 arch_zbook dhcpcd[18730]: dhcpcd not running
Dec 31 22:56:33 arch_zbook wicd[445]: dhcpcd not running
Dec 31 22:56:33 arch_zbook kernel: IPv6: ADDRCONF(NETDEV_UP): enp0s25: link is not ready
Dec 31 22:56:33 arch_zbook wicd[445]: Failed to connect to non-global ctrl_ifname: enp0s25  error: No such file or directory
Dec 31 22:56:33 arch_zbook kernel: e1000e: enp0s25 NIC Link is Down
Dec 31 22:56:33 arch_zbook dhcpcd[18718]: dhcpcd not running
Dec 31 22:56:33 arch_zbook wicd[445]: dhcpcd not running
Dec 31 22:56:33 arch_zbook wicd[445]: Failed to connect to non-global ctrl_ifname: wlp62s0  error: No such file or directory
Dec 31 22:56:33 arch_zbook kernel: IPv6: ADDRCONF(NETDEV_UP): wlp62s0: link is not ready
Dec 31 22:56:32 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:32 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:32 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:32 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:32 arch_zbook dhcpcd[18708]: dhcpcd not running
Dec 31 22:56:32 arch_zbook wicd[445]: dhcpcd not running
Dec 31 22:56:29 arch_zbook kernel: IPv6: ADDRCONF(NETDEV_UP): wlp62s0: link is not ready
Dec 31 22:56:29 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:29 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:29 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:29 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:24 arch_zbook kernel: psmouse serio3: synaptics: queried min coordinates: x [1324..], y [1248..]
Dec 31 22:56:24 arch_zbook kernel: psmouse serio3: synaptics: queried max coordinates: x [..5660], y [..4730]
Dec 31 22:56:24 arch_zbook kernel: IPv6: ADDRCONF(NETDEV_UP): enp0s25: link is not ready
Dec 31 22:56:24 arch_zbook wicd[445]: Failed to connect to non-global ctrl_ifname: enp0s25  error: No such file or directory
Dec 31 22:56:23 arch_zbook kernel: e1000e: enp0s25 NIC Link is Down
Dec 31 22:56:23 arch_zbook dhcpcd[18692]: dhcpcd not running
Dec 31 22:56:23 arch_zbook wicd[445]: dhcpcd not running
Dec 31 22:56:23 arch_zbook kernel: IPv6: ADDRCONF(NETDEV_UP): wlp62s0: link is not ready
Dec 31 22:56:23 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:23 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Endpoint registered: sender=:1.18 path=/MediaEndpoint/A2DPSink
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Endpoint registered: sender=:1.18 path=/MediaEndpoint/A2DPSource
Dec 31 22:56:23 arch_zbook systemd-logind[444]: Operation 'sleep' finished.
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: sap-server: Operation not permitted (1)
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Sap driver initialization failed.
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Not enough free handles to register service
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Not enough free handles to register service
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: gatt-time-server: Input/output error (5)
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Current Time Service could not be registered
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Not enough free handles to register service
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Not enough free handles to register service
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Not enough free handles to register service
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Error adding Link Loss service
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Not enough free handles to register service
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Failed to obtain handles for "Service Changed" characteristic
Dec 31 22:56:23 arch_zbook kernel: Bluetooth: hci0: Intel Bluetooth firmware patch completed and activated
Dec 31 22:56:23 arch_zbook dbus[447]: [system] Rejected send message, 3 matched rules; type="error", sender=":1.18" (uid=1000 pid=880 comm="/usr/bin/pulseaudio --daemonize=no ") interface="(unset)" member="(unset
Dec 31 22:56:23 arch_zbook dbus[447]: [system] Rejected send message, 3 matched rules; type="error", sender=":1.18" (uid=1000 pid=880 comm="/usr/bin/pulseaudio --daemonize=no ") interface="(unset)" member="(unset
Dec 31 22:56:23 arch_zbook dbus[447]: [system] Rejected send message, 3 matched rules; type="error", sender=":1.18" (uid=1000 pid=880 comm="/usr/bin/pulseaudio --daemonize=no ") interface="(unset)" member="(unset
Dec 31 22:56:23 arch_zbook dbus[447]: [system] Rejected send message, 3 matched rules; type="error", sender=":1.18" (uid=1000 pid=880 comm="/usr/bin/pulseaudio --daemonize=no ") interface="(unset)" member="(unset
Dec 31 22:56:23 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:23 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:23 arch_zbook root[18682]: ACPI group/action undefined: thermal_zone / LNXTHERM:04
Dec 31 22:56:23 arch_zbook root[18680]: ACPI group/action undefined: thermal_zone / LNXTHERM:01
Dec 31 22:56:23 arch_zbook root[18678]: ACPI group/action undefined: processor / LNXCPU:07
Dec 31 22:56:23 arch_zbook dhcpcd[643]: dhcpcd exited
Dec 31 22:56:23 arch_zbook root[18673]: ACPI group/action undefined: processor / LNXCPU:06
Dec 31 22:56:23 arch_zbook root[18669]: ACPI group/action undefined: processor / LNXCPU:05
Dec 31 22:56:23 arch_zbook root[18663]: ACPI group/action undefined: processor / LNXCPU:04
Dec 31 22:56:23 arch_zbook dhcpcd[643]: wlp62s0: removing interface
Dec 31 22:56:23 arch_zbook dhcpcd[643]: received SIGALRM, releasing
Dec 31 22:56:23 arch_zbook root[18657]: ACPI group/action undefined: processor / LNXCPU:03
Dec 31 22:56:23 arch_zbook dhcpcd[643]: wlp62s0: deleting default route via 192.168.0.1
Dec 31 22:56:23 arch_zbook dhcpcd[643]: wlp62s0: deleting route to 192.168.0.0/24
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Endpoint unregistered: sender=:1.18 path=/MediaEndpoint/A2DPSink
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Endpoint unregistered: sender=:1.18 path=/MediaEndpoint/A2DPSource
Dec 31 22:56:23 arch_zbook acpid[459]: input device has been disconnected, fd 21
Dec 31 22:56:23 arch_zbook root[18652]: ACPI group/action undefined: processor / LNXCPU:02
Dec 31 22:56:23 arch_zbook root[18650]: ACPI group/action undefined: processor / LNXCPU:01
Dec 31 22:56:23 arch_zbook root[18644]: ACPI group/action undefined: processor / LNXCPU:00
Dec 31 22:56:23 arch_zbook systemd[1]: Stopped target Suspend.
Dec 31 22:56:23 arch_zbook systemd[1]: suspend.target: Unit is bound to inactive unit systemd-suspend.service. Stopping, too.
Dec 31 22:56:23 arch_zbook dhcpcd[18635]: waiting for pid 643 to exit
Dec 31 22:56:23 arch_zbook dhcpcd[18635]: sending signal ARLM to pid 643
Dec 31 22:56:23 arch_zbook systemd[1]: Reached target Suspend.
Dec 31 22:56:23 arch_zbook systemd[1]: Stopped target Sleep.
Dec 31 22:56:23 arch_zbook systemd[1]: sleep.target: Unit not needed anymore. Stopping.
Dec 31 22:56:23 arch_zbook systemd[1]: Started Suspend.
Dec 31 22:56:23 arch_zbook systemd-sleep[18453]: System resumed.
Dec 31 22:56:23 arch_zbook root[18633]: ACPI action undefined: ACPI0003:00
Dec 31 22:56:23 arch_zbook dbus[447]: [system] Rejected send message, 3 matched rules; type="method_return", sender=":1.18" (uid=1000 pid=880 comm="/usr/bin/pulseaudio --daemonize=no ") interface="(unset)" member
Dec 31 22:56:23 arch_zbook systemd[1]: Reached target Bluetooth.
Dec 31 22:56:23 arch_zbook systemd[1]: Stopped target Bluetooth.
Dec 31 22:56:23 arch_zbook systemd[1]: bluetooth.target: Unit not needed anymore. Stopping.
Dec 31 22:56:23 arch_zbook root[18616]: ACPI group/action undefined: thermal_zone / LNXTHERM:00
Dec 31 22:56:23 arch_zbook systemd[1]: Started Load/Save RF Kill Switch Status.
Dec 31 22:56:23 arch_zbook root[18600]: LID opened
Dec 31 22:56:23 arch_zbook systemd-logind[444]: Lid opened.
Dec 31 22:56:23 arch_zbook bluetoothd[4650]: Unable to get io data for Headset Voice gateway: getpeername: Transport endpoint is not connected (107)
Dec 31 22:56:23 arch_zbook systemd[1]: Starting Load/Save RF Kill Switch Status...
Dec 31 22:56:23 arch_zbook acpid[459]: client 773[0:1000] has disconnected
Dec 31 22:56:23 arch_zbook kernel: Bluetooth: hci0: Intel Bluetooth firmware file: intel/ibt-hw-37.7.10-fw-1.80.2.3.d.bseq
Dec 31 22:56:23 arch_zbook kernel: Bluetooth: hci0: read Intel version: 370710018002030d00
Dec 31 22:56:23 arch_zbook systemd[733]: Time has been changed
Dec 31 22:56:23 arch_zbook dhcpcd[643]: wlp62s0: carrier lost
Dec 31 22:56:23 arch_zbook systemd[1]: Time has been changed
Dec 31 22:56:23 arch_zbook kernel: done.
Dec 31 22:56:23 arch_zbook kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000 flags 0x2] has bogus alignment
Dec 31 22:56:23 arch_zbook kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000 flags 0x2] has bogus alignment
Dec 31 22:56:23 arch_zbook kernel: acpi PNP0501:00: Still not present
Dec 31 22:56:23 arch_zbook kernel: Restarting tasks ... 
Dec 31 22:56:23 arch_zbook kernel: PM: Finishing wakeup.
Dec 31 22:56:23 arch_zbook kernel: PM: resume of devices complete after 1610.068 msecs
Dec 31 22:56:23 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:23 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:23 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:23 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:23 arch_zbook kernel: tpm_tis 00:07: TPM is disabled/deactivated (0x7)
Dec 31 22:56:23 arch_zbook kernel: parport_pc 00:04: activated
Dec 31 22:56:23 arch_zbook acpid[459]: client 773[0:1000] has disconnected
Dec 31 22:56:23 arch_zbook kernel: Bluetooth: hci0: Intel Bluetooth firmware file: intel/ibt-hw-37.7.10-fw-1.80.2.3.d.bseq
Dec 31 22:56:23 arch_zbook kernel: Bluetooth: hci0: read Intel version: 370710018002030d00
Dec 31 22:56:23 arch_zbook systemd[733]: Time has been changed
Dec 31 22:56:23 arch_zbook dhcpcd[643]: wlp62s0: carrier lost
Dec 31 22:56:23 arch_zbook systemd[1]: Time has been changed
Dec 31 22:56:23 arch_zbook kernel: done.
Dec 31 22:56:23 arch_zbook kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000 flags 0x2] has bogus alignment
Dec 31 22:56:23 arch_zbook kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000 flags 0x2] has bogus alignment
Dec 31 22:56:23 arch_zbook kernel: acpi PNP0501:00: Still not present
Dec 31 22:56:23 arch_zbook kernel: Restarting tasks ... 
Dec 31 22:56:23 arch_zbook kernel: PM: Finishing wakeup.
Dec 31 22:56:23 arch_zbook kernel: PM: resume of devices complete after 1610.068 msecs
Dec 31 22:56:23 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:23 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:23 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:23 arch_zbook kernel: iwlwifi 0000:3e:00.0: L1 Enabled - LTR Enabled
Dec 31 22:56:23 arch_zbook kernel: tpm_tis 00:07: TPM is disabled/deactivated (0x7)
Dec 31 22:56:23 arch_zbook kernel: parport_pc 00:04: activated
Dec 31 22:56:23 arch_zbook kernel: rtc_cmos 00:03: System wakeup disabled by ACPI
Dec 31 22:56:23 arch_zbook kernel: usb 3-7: reset high-speed USB device number 4 using xhci_hcd
Dec 31 22:56:23 arch_zbook kernel: usb 3-5: reset full-speed USB device number 3 using xhci_hcd
Dec 31 22:56:23 arch_zbook kernel: ata4: SATA link down (SStatus 0 SControl 300)
Dec 31 22:56:23 arch_zbook kernel: ata3: SATA link down (SStatus 0 SControl 300)
Dec 31 22:56:23 arch_zbook kernel: usb 3-12: reset full-speed USB device number 5 using xhci_hcd
Dec 31 22:56:23 arch_zbook kernel: ata7.00: configured for UDMA/100
Dec 31 22:56:23 arch_zbook kernel: ata7: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
Dec 31 22:56:23 arch_zbook kernel: pciehp 0000:3d:03.0:pcie24: Cannot add device at 0000:60:00
Dec 31 22:56:23 arch_zbook kernel: pciehp 0000:3d:03.0:pcie24: Device 0000:60:00.0 already exists at 0000:60:00, cannot hot-add
Dec 31 22:56:23 arch_zbook kernel: pciehp 0000:3d:03.0:pcie24: Cannot add device at 0000:60:00
Dec 31 22:56:23 arch_zbook kernel: pciehp 0000:3d:03.0:pcie24: Device 0000:60:00.0 already exists at 0000:60:00, cannot hot-add
Dec 31 22:56:23 arch_zbook kernel: xhci_hcd 0000:00:14.0: port 4 resume PLC timeout
Dec 31 22:56:23 arch_zbook kernel: xhci_hcd 0000:00:14.0: port 6 resume PLC timeout
Dec 31 22:56:23 arch_zbook kernel: xhci_hcd 0000:00:14.0: port 11 resume PLC timeout
Dec 31 22:56:23 arch_zbook kernel: sd 6:0:0:0: [sda] Starting disk
Dec 31 22:56:23 arch_zbook kernel: pciehp 0000:3d:02.0:pcie24: Card not present on Slot(0-1)
Dec 31 22:56:23 arch_zbook kernel: pciehp 0000:3d:03.0:pcie24: slot(0-2): Link Up event
Dec 31 22:56:23 arch_zbook kernel: e1000e 0000:00:19.0: System wakeup disabled by ACPI
Dec 31 22:56:23 arch_zbook kernel: PM: early resume of devices complete after 64.705 msecs
Dec 31 22:56:23 arch_zbook kernel: PM: noirq resume of devices complete after 92.505 msecs
Dec 31 22:56:23 arch_zbook kernel: ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI
Dec 31 22:56:23 arch_zbook kernel: xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI
Dec 31 22:56:23 arch_zbook kernel: ehci-pci 0000:00:1a.0: System wakeup disabled by ACPI
Dec 31 22:56:23 arch_zbook kernel: acpi LNXPOWER:01: Turning OFF
Dec 31 22:56:23 arch_zbook kernel: acpi LNXPOWER:02: Turning OFF
Dec 31 22:56:23 arch_zbook kernel: ACPI: Waking up from system sleep state S3
Dec 31 22:56:23 arch_zbook kernel: CPU7 is up
Dec 31 22:56:23 arch_zbook kernel:  cache: parent cpu7 should not be sleeping
Dec 31 22:56:23 arch_zbook kernel: smpboot: Booting Node 0 Processor 7 APIC 0x7
Dec 31 22:56:23 arch_zbook kernel: CPU6 is up
Dec 31 22:56:23 arch_zbook kernel:  cache: parent cpu6 should not be sleeping
Dec 31 22:56:23 arch_zbook kernel: smpboot: Booting Node 0 Processor 6 APIC 0x6
Dec 31 22:56:23 arch_zbook kernel: CPU5 is up
Dec 31 22:56:23 arch_zbook kernel:  cache: parent cpu5 should not be sleeping
Dec 31 22:56:23 arch_zbook kernel: smpboot: Booting Node 0 Processor 5 APIC 0x5
Dec 31 22:56:23 arch_zbook kernel: CPU4 is up
Dec 31 22:56:23 arch_zbook kernel:  cache: parent cpu4 should not be sleeping
Dec 31 22:56:23 arch_zbook kernel: smpboot: Booting Node 0 Processor 4 APIC 0x4
Dec 31 22:56:23 arch_zbook kernel: CPU3 is up
Dec 31 22:56:23 arch_zbook kernel:  cache: parent cpu3 should not be sleeping
Dec 31 22:56:23 arch_zbook kernel: smpboot: Booting Node 0 Processor 3 APIC 0x3
Dec 31 22:56:23 arch_zbook kernel: CPU2 is up
Dec 31 22:56:23 arch_zbook kernel:  cache: parent cpu2 should not be sleeping
Dec 31 22:56:23 arch_zbook kernel: smpboot: Booting Node 0 Processor 2 APIC 0x2
Dec 31 22:56:23 arch_zbook kernel: CPU1 is up
Dec 31 22:56:23 arch_zbook kernel:  cache: parent cpu1 should not be sleeping
Dec 31 22:56:23 arch_zbook kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1
Dec 31 22:56:23 arch_zbook kernel: x86: Booting SMP configuration:
Dec 31 22:56:23 arch_zbook kernel: Enabling non-boot CPUs ...
Dec 31 22:56:23 arch_zbook kernel: PM: Restoring platform NVS memory
Dec 31 22:56:23 arch_zbook kernel: ACPI : EC: EC started
Dec 31 22:56:23 arch_zbook kernel: ACPI: Low-level resume complete
Dec 31 22:56:23 arch_zbook kernel: smpboot: CPU 7 is now offline
Dec 31 22:56:23 arch_zbook kernel: smpboot: CPU 6 is now offline
Dec 31 22:56:23 arch_zbook kernel: smpboot: CPU 5 is now offline
Dec 31 22:56:23 arch_zbook kernel: smpboot: CPU 4 is now offline
Dec 31 22:56:23 arch_zbook kernel: smpboot: CPU 3 is now offline
Dec 31 22:56:23 arch_zbook kernel: smpboot: CPU 2 is now offline
Dec 31 22:56:23 arch_zbook kernel: smpboot: CPU 1 is now offline
Dec 31 22:56:23 arch_zbook kernel: Disabling non-boot CPUs ...
Dec 31 22:56:23 arch_zbook kernel: PM: Saving platform NVS memory
Dec 31 22:56:23 arch_zbook kernel: ACPI : EC: EC stopped
Dec 31 22:56:23 arch_zbook kernel: ACPI: Preparing to enter system sleep state S3
Dec 31 22:56:23 arch_zbook kernel: PM: noirq suspend of devices complete after 16.865 msecs
Dec 31 22:56:23 arch_zbook kernel: xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI
Dec 31 22:56:23 arch_zbook kernel: e1000e 0000:00:19.0: System wakeup enabled by ACPI
Dec 31 22:56:23 arch_zbook kernel: ehci-pci 0000:00:1a.0: System wakeup enabled by ACPI
Dec 31 22:56:23 arch_zbook kernel: ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI
Dec 31 22:56:23 arch_zbook kernel: PM: late suspend of devices complete after 23.285 msecs
Dec 31 22:56:23 arch_zbook kernel: PM: suspend of devices complete after 487.725 msecs
Dec 31 22:56:23 arch_zbook kernel: e1000e: EEE TX LPI TIMER: 00000011
Dec 31 22:56:23 arch_zbook kernel: parport_pc 00:04: disabled
Dec 31 22:56:23 arch_zbook kernel: sd 6:0:0:0: [sda] Stopping disk
Dec 31 22:56:23 arch_zbook kernel: sd 6:0:0:0: [sda] Synchronizing SCSI cache
Dec 31 22:56:23 arch_zbook kernel: wlp62s0: deauthenticating from 00:26:88:e0:30:a0 by local choice (Reason: 3=DEAUTH_LEAVING)
Dec 31 22:56:23 arch_zbook kernel: Suspending console(s) (use no_console_suspend to debug)
Dec 31 22:56:23 arch_zbook kernel: PM: Suspending system (mem)
Dec 31 22:56:23 arch_zbook kernel: Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
Dec 31 22:56:23 arch_zbook kernel: Freezing user space processes ... (elapsed 0.001 seconds) done.
Dec 31 15:57:51 arch_zbook kernel: PM: Preparing system for sleep (mem)
Dec 31 15:57:51 arch_zbook kernel: PM: Syncing filesystems ... done.
Dec 31 15:57:51 arch_zbook root[18455]: ACPI group/action undefined: PNP0C14:01 / 00000080
Dec 31 15:57:51 arch_zbook systemd-sleep[18453]: Suspending system...
Dec 31 15:57:51 arch_zbook systemd[1]: Starting Suspend...
Dec 31 15:57:51 arch_zbook systemd[1]: Reached target Sleep.
Dec 31 15:57:51 arch_zbook systemd-logind[444]: Suspending...
Dec 31 15:57:51 arch_zbook root[18451]: LID closed
Dec 31 15:57:51 arch_zbook kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000 flags 0x2] has bogus alignment
Dec 31 15:57:51 arch_zbook kernel: i915 0000:00:02.0: BAR 6: [??? 0x00000000 flags 0x2] has bogus alignment
Dec 31 15:57:51 arch_zbook systemd-logind[444]: Lid closed.

Last edited by jwhendy (2016-01-01 10:49:48)

jwhendy

Member

Registered: 2010-04-01

Posts: 621

Re: Laptop resumes to terminal screen with pciehp hot-add error, frozen

Anyone? I can resume, but I'm greeted to a screen filled with these pciehp hot-add errors every time. Something's awry. In the meantime, there's some old stuff around:

- 2 year old kernel bug report with no action
- arch bug report with no response other than asking if kernel 3.1x is any different
- arch forum post about blacklisting mei and mei_me (didn't change anything for me)

Anything at all would be helpful...what device is this, what is it trying to "hot-add", is this anything to be concerned about, if not how can I suppress the message... just looking for some direction as I really have no idea.

alphaniner

Member

From: Ancapistan

Registered: 2010-07-12

Posts: 2,810

Re: Laptop resumes to terminal screen with pciehp hot-add error, frozen

what device is this

... Device 0000:60:00.0 already exists ...

$ lspci
...
60:00.0 Unassigned class [ff00]: Realtek Semiconductor Co., Ltd. RTS5249 PCI Express Card Reader (rev 01)

---

But whether the Constitution really be one thing, or another, this much is certain - that it has either authorized such a government as we have had, or has been powerless to prevent it. In either case, it is unfit to exist.
-Lysander Spooner

jwhendy

Member

Registered: 2010-04-01

Posts: 621

Re: Laptop resumes to terminal screen with pciehp hot-add error, frozen

@alphaniner: well, color me embarrassed! Thanks for that; I didn't even re-scan the lspci output, as googling the issue popped this post up near the top and I simply observed no one had responded for 3 months.

Any suggestions on what in the world is going on with it? I'm assuming this means a smart card reader. In googling around further knowing this, there's some mention of acpiphp being involved, and trying it along with pciehp.pciehp_force=0. I don't seem to have this module. I do have an acpiphp_ibm module, but when I try to modprobe I get:

modprobe: ERROR: could not insert 'acpiphp_ibm': No such device

Not sure what to do at this point. I'm not seeing a pciehp module, not finding much information about acpiphp on arch, or much else about what the issue is. I'd be fine to just disable the device as I don't use it?

alphaniner

Member

From: Ancapistan

Registered: 2010-07-12

Posts: 2,810

Re: Laptop resumes to terminal screen with pciehp hot-add error, frozen

If I'm not mistaken, pciehp and acpiphp are built in to the kernel:

$ zgrep -i "hotplug_pci" /proc/config.gz
CONFIG_HOTPLUG_PCI_PCIE=y
CONFIG_HOTPLUG_PCI=y
CONFIG_HOTPLUG_PCI_ACPI=y
CONFIG_HOTPLUG_PCI_ACPI_IBM=m
CONFIG_HOTPLUG_PCI_CPCI=y
CONFIG_HOTPLUG_PCI_CPCI_ZT5550=m
CONFIG_HOTPLUG_PCI_CPCI_GENERIC=m
CONFIG_HOTPLUG_PCI_SHPC=m

I don't know if its possible to use kernel command line options to control builtins.

acpiphp_ibm is "ACPI Hot Plug PCI Controller Driver IBM extension". Probably not relevant to your hardware.

Since you don't use the device, I can't see any reason not to try disabling it.

---

But whether the Constitution really be one thing, or another, this much is certain - that it has either authorized such a government as we have had, or has been powerless to prevent it. In either case, it is unfit to exist.
-Lysander Spooner