You are not logged in.

Pages: 1

#1 2017-04-01 15:58:47

Xwang
Member
Registered: 2012-05-14
Posts: 353

Randomic hangs after suspend

Hi to all.
I've an Asus nv752 sincelast year and it used to suspend without issues.
Since about a couple of weeks ago it has started to have random hangs after RAM suspensions (I've set to suspend in RAM when I close the lid). These present a black screen and no response to keyboard commands (even the alt-stamp-REISUB).
So in order to try to investigate and to be sure to syncronize the filesystem before each suspension I've created this bash file named system-sleep-log-and-sync.sh in the /usr/lib/systemd/system-sleep/system-sleep directory:

#!/bin/sh
#This script logs the sleep actions and syncronize before going to sleep
echo "${0##*/} :-> Starting with parameters $1 and $2..."
case $1/$2 in
  pre/*)
    echo "${0##*/} :-> Going to $2..."
    sync
    echo "${0##*/} :-> Sync executed ... now I go to $2..."
    ;;
  post/*)
    echo "${0##*/} :-> Waking up from $2..."
    ;;
esac

When everything works correctly I've this journalctl -r output:

apr 01 10:08:07 n752vx systemd-sleep[27289]: system-sleep-log-and-sync.sh :-> Waking up from suspend...
apr 01 10:08:07 n752vx systemd-sleep[27289]: system-sleep-log-and-sync.sh :-> Starting with parameters post and suspend...
apr 01 10:08:07 n752vx systemd[1]: bluetooth.target: Unit not needed anymore. Stopping.
apr 01 10:08:07 n752vx kdeinit5[863]: kscreen.kded: Lid opened!
apr 01 10:08:07 n752vx systemd-sleep[27289]: System resumed.
apr 01 10:08:07 n752vx systemd[1]: Starting Load/Save RF Kill Switch Status...
apr 01 10:08:07 n752vx systemd[1]: Starting Rotate log files...
apr 01 10:08:07 n752vx systemd[1]: Starting Update man-db cache...
apr 01 10:08:07 n752vx systemd[1]: Started Verify integrity of password and group files.
apr 01 10:08:07 n752vx dhcpcd[515]: wlp2s0: deleting default route via 192.168.1.254
apr 01 10:08:07 n752vx kdeinit5[863]: kscreen.kded: Lid closed without system going to suspend -> turning off the screen
apr 01 10:08:07 n752vx rtkit-daemon[939]: Demoted 1 threads.
apr 01 10:08:07 n752vx systemd[798]: Time has been changed
apr 01 10:08:07 n752vx rtkit-daemon[939]: Successfully demoted thread 926 of process 926 (/usr/bin/pulseaudio).
apr 01 10:08:07 n752vx plasmashell[911]: Time engine Clock skew signaled
apr 01 10:08:07 n752vx rtkit-daemon[939]: Demoting known real-time threads.
apr 01 10:08:07 n752vx systemd-logind[508]: Lid opened.
apr 01 10:08:07 n752vx rtkit-daemon[939]: The canary thread is apparently starving. Taking action.
apr 01 10:08:07 n752vx systemd[1]: Time has been changed
apr 01 10:08:07 n752vx kernel: Restarting tasks ... done.
apr 01 10:08:07 n752vx kernel: PM: Finishing wakeup.
apr 01 10:08:07 n752vx kernel: usb 1-9:1.1: rebind failed: -517
apr 01 10:08:07 n752vx kernel: usb 1-9:1.0: rebind failed: -517
apr 01 10:08:07 n752vx kernel: PM: resume of devices complete after 4690.019 msecs
apr 01 10:08:07 n752vx kernel: usb 1-9: reset full-speed USB device number 8 using xhci_hcd
apr 01 10:08:07 n752vx kernel: iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
apr 01 10:08:07 n752vx kernel: iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
apr 01 10:08:07 n752vx kernel: iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
apr 01 10:08:07 n752vx kernel: iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
apr 01 10:08:07 n752vx kernel: usb 1-1.4: reset low-speed USB device number 7 using xhci_hcd
apr 01 10:08:07 n752vx kernel: usb 1-1.3: reset low-speed USB device number 6 using xhci_hcd
apr 01 10:08:07 n752vx kernel: usb 1-1.2: reset high-speed USB device number 4 using xhci_hcd
apr 01 10:08:07 n752vx kernel: usb 1-4: reset high-speed USB device number 3 using xhci_hcd
apr 01 10:08:07 n752vx kernel: sd 3:0:0:0: [sdb] Starting disk
apr 01 10:08:07 n752vx kernel: [drm] RC6 off
apr 01 10:08:07 n752vx kernel: ata4.00: configured for UDMA/133
apr 01 10:08:07 n752vx kernel: ata4: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
apr 01 10:08:07 n752vx kernel: usb 1-1: reset high-speed USB device number 2 using xhci_hcd
apr 01 10:08:07 n752vx kernel: ata2.00: configured for UDMA/133
apr 01 10:08:07 n752vx kernel: ata1.00: configured for UDMA/133
apr 01 10:08:07 n752vx kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
apr 01 10:08:07 n752vx kernel: ata3: SATA link down (SStatus 4 SControl 300)
apr 01 10:08:07 n752vx kernel: ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
apr 01 10:08:07 n752vx kernel: sd 0:0:0:0: [sda] Starting disk
apr 01 10:08:07 n752vx kernel: xhci_hcd 0000:00:14.0: port 8 resume PLC timeout
apr 01 10:08:07 n752vx kernel: r8169 0000:03:00.1 enp3s0f1: link down
apr 01 10:08:07 n752vx kernel: rtc_cmos 00:02: System wakeup disabled by ACPI
apr 01 10:08:07 n752vx kernel: usb usb4: root hub lost power or was reset
apr 01 10:08:07 n752vx kernel: usb usb3: root hub lost power or was reset
apr 01 10:08:07 n752vx kernel: pcieport 0000:00:1c.3: System wakeup disabled by ACPI
apr 01 10:08:07 n752vx kernel: [drm] GuC firmware load skipped
apr 01 10:08:07 n752vx kernel: ACPI : EC: event unblocked
apr 01 10:08:07 n752vx kernel: PM: early resume of devices complete after 11.168 msecs
apr 01 10:08:07 n752vx kernel: PM: noirq resume of devices complete after 456.977 msecs
apr 01 10:08:07 n752vx kernel: xhci_hcd 0000:04:00.0: System wakeup disabled by ACPI
apr 01 10:08:07 n752vx kernel: ACPI : EC: interrupt unblocked
apr 01 10:08:07 n752vx kernel: ACPI: Waking up from system sleep state S3
apr 01 10:08:07 n752vx kernel: CPU7 is up
apr 01 10:08:07 n752vx kernel:  cache: parent cpu7 should not be sleeping
apr 01 10:08:07 n752vx kernel: smpboot: Booting Node 0 Processor 7 APIC 0x7
apr 01 10:08:07 n752vx kernel: CPU6 is up
apr 01 10:08:07 n752vx kernel:  cache: parent cpu6 should not be sleeping
apr 01 10:08:07 n752vx kernel: smpboot: Booting Node 0 Processor 6 APIC 0x5
apr 01 10:08:07 n752vx kernel: CPU5 is up
apr 01 10:08:07 n752vx kernel:  cache: parent cpu5 should not be sleeping
apr 01 10:08:07 n752vx kernel: smpboot: Booting Node 0 Processor 5 APIC 0x3
apr 01 10:08:07 n752vx kernel: CPU4 is up
apr 01 10:08:07 n752vx kernel:  cache: parent cpu4 should not be sleeping
apr 01 10:08:07 n752vx kernel: smpboot: Booting Node 0 Processor 4 APIC 0x1
apr 01 10:08:07 n752vx kernel: CPU3 is up
apr 01 10:08:07 n752vx kernel:  cache: parent cpu3 should not be sleeping
apr 01 10:08:07 n752vx kernel: smpboot: Booting Node 0 Processor 3 APIC 0x6
apr 01 10:08:07 n752vx kernel: CPU2 is up
apr 01 10:08:07 n752vx kernel:  cache: parent cpu2 should not be sleeping
apr 01 10:08:07 n752vx kernel: smpboot: Booting Node 0 Processor 2 APIC 0x4
apr 01 10:08:07 n752vx kernel: CPU1 is up
apr 01 10:08:07 n752vx kernel:  cache: parent cpu1 should not be sleeping
apr 01 10:08:07 n752vx kernel: smpboot: Booting Node 0 Processor 1 APIC 0x2
apr 01 10:08:07 n752vx kernel: x86: Booting SMP configuration:
apr 01 10:08:07 n752vx kernel: Enabling non-boot CPUs ...
apr 01 10:08:07 n752vx kernel: Suspended for 49284.213 seconds
apr 01 10:08:07 n752vx kernel: PM: Restoring platform NVS memory
apr 01 10:08:07 n752vx kernel: ACPI : EC: EC started
apr 01 10:08:07 n752vx kernel: ACPI: Low-level resume complete
apr 01 10:08:07 n752vx kernel: smpboot: CPU 7 is now offline
apr 01 10:08:07 n752vx kernel: smpboot: CPU 6 is now offline
apr 01 10:08:07 n752vx kernel: smpboot: CPU 5 is now offline
apr 01 10:08:07 n752vx kernel: smpboot: CPU 4 is now offline
apr 01 10:08:07 n752vx kernel: smpboot: CPU 3 is now offline
apr 01 10:08:07 n752vx kernel: smpboot: CPU 2 is now offline
apr 01 10:08:07 n752vx kernel: smpboot: CPU 1 is now offline
apr 01 10:08:07 n752vx kernel: Disabling non-boot CPUs ...
apr 01 10:08:07 n752vx kernel: PM: Saving platform NVS memory
apr 01 10:08:07 n752vx kernel: ACPI : EC: EC stopped
apr 01 10:08:07 n752vx kernel: ACPI: Preparing to enter system sleep state S3
apr 01 10:08:07 n752vx kernel: PM: noirq suspend of devices complete after 471.173 msecs
apr 01 10:08:07 n752vx kernel: ACPI : EC: interrupt blocked
apr 01 10:08:07 n752vx kernel: pcieport 0000:00:1c.3: System wakeup enabled by ACPI
apr 01 10:08:07 n752vx kernel: xhci_hcd 0000:04:00.0: System wakeup enabled by ACPI
apr 01 10:08:07 n752vx kernel: PM: late suspend of devices complete after 24.513 msecs
apr 01 10:08:07 n752vx kernel: PM: suspend of devices complete after 955.428 msecs
apr 01 10:08:07 n752vx kernel: ACPI : EC: event blocked
apr 01 10:08:07 n752vx kernel: sd 0:0:0:0: [sda] Stopping disk
apr 01 10:08:07 n752vx kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
apr 01 10:08:07 n752vx kernel: sd 3:0:0:0: [sdb] Stopping disk
apr 01 10:08:07 n752vx kernel: sd 3:0:0:0: [sdb] Synchronizing SCSI cache
apr 01 10:08:07 n752vx kernel: Suspending console(s) (use no_console_suspend to debug)
apr 01 10:08:07 n752vx kernel: PM: Suspending system (mem)
apr 01 10:08:07 n752vx kernel: Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
apr 01 10:08:07 n752vx kernel: Freezing user space processes ... (elapsed 0.037 seconds) done.
apr 01 10:08:07 n752vx kernel: PM: Preparing system for sleep (mem)
apr 01 10:08:07 n752vx kernel: PM: Syncing filesystems ... done.
mar 31 20:26:36 n752vx systemd-sleep[27289]: Suspending system...
mar 31 20:26:36 n752vx systemd-sleep[27289]: system-sleep-log-and-sync.sh :-> Sync executed ... now I go to suspend...
mar 31 20:26:36 n752vx systemd-sleep[27289]: system-sleep-log-and-sync.sh :-> Going to suspend...
mar 31 20:26:36 n752vx systemd-sleep[27289]: system-sleep-log-and-sync.sh :-> Starting with parameters pre and suspend...
mar 31 20:26:36 n752vx systemd[1]: Starting Suspend...

When it hangs the log is the following:

apr 01 16:51:57 n752vx kernel: x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers'
apr 01 16:51:57 n752vx kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
apr 01 16:51:57 n752vx kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
apr 01 16:51:57 n752vx kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
apr 01 16:51:57 n752vx kernel: Command line: BOOT_IMAGE=/vmlinuz-linux-lts root=UUID=74296c4e-84df-4eda-87a1-09be9d8e114b rw i915.enable_rc6=0
apr 01 16:51:57 n752vx kernel: Linux version 4.9.18-1-lts (builduser@andyrtr) (gcc version 6.3.1 20170306 (GCC) ) #1 SMP Sun Mar 26 14:21:00 CEST 2017
apr 01 16:51:57 n752vx kernel: microcode: microcode updated early to revision 0x9e, date = 2016-06-22
apr 01 16:51:57 n752vx systemd-journald[195]: Time spent on flushing to /var is 621us for 0 entries.
-- Reboot --
apr 01 12:11:01 n752vx systemd-sleep[24713]: Suspending system...
apr 01 12:11:01 n752vx systemd-sleep[24713]: system-sleep-log-and-sync.sh :-> Sync executed ... now I go to suspend...
apr 01 12:11:01 n752vx systemd-sleep[24713]: system-sleep-log-and-sync.sh :-> Going to suspend...
apr 01 12:11:01 n752vx systemd-sleep[24713]: system-sleep-log-and-sync.sh :-> Starting with parameters pre and suspend...
apr 01 12:11:01 n752vx systemd[1]: Starting Suspend...
apr 01 12:11:01 n752vx plasmashell[911]: networkmanager-qt: virtual void NetworkManager::DevicePrivate::propertyChanged(const QString&, const QVariant&) Unhandled property "TxBytes"
apr 01 12:11:01 n752vx plasmashell[911]: networkmanager-qt: virtual void NetworkManager::DevicePrivate::propertyChanged(const QString&, const QVariant&) Unhandled property "RxBytes"
apr 01 12:11:01 n752vx systemd[1]: Reached target Sleep.

As far as I know, the suspend has happened (in fact there is the output of the script and the synchronization), but then it does not restart (the power goes on but nothing is written to the journal) and I need to force the reboot pressing the power button.
Can you help me,
please?
Thank you,
Xwang

I'm still learning English so please excuse me if my English is not good enough and feel free to correct me via PM if you want.

Offline

#2 2017-04-02 07:23:31

pl
Member
Registered: 2014-02-10
Posts: 32

Re: Randomic hangs after suspend

4.10 seems to have problems like this on many models. Install the linux-lts (4.9 kernel) package and see if that helps.

Offline

#3 2017-04-02 08:13:14

Xwang
Member
Registered: 2012-05-14
Posts: 353

Re: Randomic hangs after suspend

Thank you,
I've already installed lts some days ago and this hang has happened with lts.

I'm still learning English so please excuse me if my English is not good enough and feel free to correct me via PM if you want.

Offline

#4 2017-04-19 13:03:13

Xwang
Member
Registered: 2012-05-14
Posts: 353

Re: Randomic hangs after suspend

Both lts and normal have the problem which does not happen every suspend.

I'm still learning English so please excuse me if my English is not good enough and feel free to correct me via PM if you want.

Offline

#5 2017-04-19 17:34:53

Xwang
Member
Registered: 2012-05-14
Posts: 353

Re: Randomic hangs after suspend

Today I was testing the issue running the analyze_suspend.py tool (https://01.org/blogs/rzhang/2015/best-p … ate-issues) inside a for loop in freeze mode (the "lighter" suspend mode which does not turn off the processors).
After the first two iterations, the system has hanged with the message in this image IMG_20170419_151037982.jpg.
For comparison this is the dmesg of the previous iteration which has worked correctly:

# suspend-041917-150920 n752vx freeze 4.10.10-1-ARCH
[  839.410233] PM: Syncing filesystems ... done.
[  839.736960] PM: Preparing system for sleep (freeze)
[  840.108935] Freezing user space processes ... (elapsed 0.001 seconds) done.
[  840.111227] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
[  840.113074] PM: Suspending system (freeze)
[  840.327197] calling  input15+ @ 3651, parent: i2c-ELAN1000:00
[  840.329483] call input15+ returned 0 after 3 usecs
[  840.331419] calling  i2c-ELAN1000:00+ @ 3651, parent: i2c-7
[  840.332451] call i2c-ELAN1000:00+ returned 0 after 344 usecs
[  840.333116] calling  input14+ @ 3651, parent: card0
[  840.333755] call input14+ returned 0 after 0 usecs
[  840.334345] calling  input13+ @ 3651, parent: card0
[  840.334979] call input13+ returned 0 after 0 usecs
[  840.335552] calling  input12+ @ 3651, parent: card0
[  840.336155] call input12+ returned 0 after 0 usecs
[  840.336777] calling  input11+ @ 3651, parent: card0
[  840.337404] call input11+ returned 0 after 0 usecs
[  840.338034] calling  hdaudioC0D2+ @ 3651, parent: 0000:00:1f.3
[  840.338634] call hdaudioC0D2+ returned 0 after 0 usecs
[  840.339220] calling  hdaudioC0D0+ @ 3651, parent: 0000:00:1f.3
[  840.356288] call hdaudioC0D0+ returned 0 after 16027 usecs
[  840.358450] calling  rfkill1+ @ 3651, parent: phy0
[  840.360648] call rfkill1+ returned 0 after 3 usecs
[  840.362835] calling  phy0+ @ 3651, parent: 0000:02:00.0
[  840.365015] wlp2s0: deauthenticating from 30:91:8f:ca:f1:9b by local choice (Reason: 3=DEAUTH_LEAVING)
[  840.391672] call phy0+ returned 0 after 26037 usecs
[  840.393965] calling  phy0-led+ @ 3651, parent: 0000:02:00.0
[  840.396213] call phy0-led+ returned 0 after 3 usecs
[  840.398466] calling  input10+ @ 3651, parent: LNXVIDEO:01
[  840.400701] call input10+ returned 0 after 2 usecs
[  840.402912] calling  input9+ @ 3651, parent: LNXVIDEO:00
[  840.405380] call input9+ returned 0 after 1 usecs
[  840.407591] calling  intel_backlight+ @ 3651, parent: card0-eDP-1
[  840.409832] call intel_backlight+ returned 0 after 2 usecs
[  840.412060] calling  input8+ @ 3651, parent: 1-4:1.0
[  840.414285] call input8+ returned 0 after 2 usecs
[  840.416523] calling  asus::kbd_backlight+ @ 3651, parent: asus-nb-wmi
[  840.418749] call asus::kbd_backlight+ returned 0 after 2 usecs
[  840.420983] calling  coretemp.0+ @ 3651, parent: platform
[  840.422576] call coretemp.0+ returned 0 after 1 usecs
[  840.424290] calling  input7+ @ 3651, parent: asus-nb-wmi
[  840.425985] call input7+ returned 0 after 3 usecs
[  840.427318] calling  asus-nb-wmi+ @ 3651, parent: platform
[  840.428516] call asus-nb-wmi+ returned 0 after 2 usecs
[  840.429726] calling  rfkill0+ @ 3651, parent: hci0
[  840.431036] call rfkill0+ returned 0 after 21 usecs
[  840.432270] calling  regulatory.0+ @ 3651, parent: platform
[  840.433507] call regulatory.0+ returned 0 after 1 usecs
[  840.434777] calling  iTCO_wdt+ @ 3651, parent: 0000:00:1f.4
[  840.436011] call iTCO_wdt+ returned 0 after 1 usecs
[  840.437237] calling  i2c_designware.1+ @ 3651, parent: 0000:00:15.1
[  840.438496] call i2c_designware.1+ returned 0 after 4 usecs
[  840.439782] calling  idma64.1+ @ 3651, parent: 0000:00:15.1
[  840.441013] call idma64.1+ returned 0 after 2 usecs
[  840.442269] calling  i2c_designware.0+ @ 3651, parent: 0000:00:15.0
[  840.443532] call i2c_designware.0+ returned 0 after 3 usecs
[  840.444812] calling  idma64.0+ @ 3651, parent: 0000:00:15.0
[  840.446173] call idma64.0+ returned 0 after 4 usecs
[  840.447505] calling  input0::scrolllock+ @ 3651, parent: input0
[  840.448777] call input0::scrolllock+ returned 0 after 2 usecs
[  840.450069] calling  input0::capslock+ @ 3651, parent: input0
[  840.451322] call input0::capslock+ returned 0 after 1 usecs
[  840.452578] calling  input0::numlock+ @ 3651, parent: input0
[  840.453868] call input0::numlock+ returned 0 after 0 usecs
[  840.455112] calling  input6+ @ 3651, parent: pcspkr
[  840.456372] call input6+ returned 0 after 1 usecs
[  840.457643] calling  asus-wireless::airplane+ @ 3651, parent: ATK4002:00
[  840.458911] call asus-wireless::airplane+ returned 0 after 4 usecs
[  840.460329] calling  input5+ @ 3651, parent: ATK4002:00
[  840.461657] call input5+ returned 0 after 1 usecs
[  840.462913] calling  input4+ @ 3651, parent: LNXPWRBN:00
[  840.464220] call input4+ returned 0 after 1 usecs
[  840.465440] calling  input3+ @ 3651, parent: PNP0C0E:00
[  840.466666] call input3+ returned 0 after 1 usecs
[  840.467986] calling  input2+ @ 3651, parent: PNP0C0D:00
[  840.469213] call input2+ returned 0 after 2 usecs
[  840.470443] calling  vboxdrv.0+ @ 3651, parent: platform
[  840.471664] call vboxdrv.0+ returned 0 after 2 usecs
[  840.472932] calling  1-9+ @ 3651, parent: usb1
[  840.475026] call 1-9+ returned 0 after 1270 usecs
[  840.475648] calling  1-4+ @ 3651, parent: usb1
[  840.476254] call 1-4+ returned 0 after 1 usecs
[  840.476894] calling  input1+ @ 3651, parent: 0003:093A:2510.0001
[  840.477511] call input1+ returned 0 after 0 usecs
[  840.478135] calling  1-1+ @ 3651, parent: usb1
[  840.478842] call 1-1+ returned 0 after 105 usecs
[  840.479464] calling  3:0:0:0+ @ 3651, parent: target3:0:0
[  840.480143] sd 3:0:0:0: [sdb] Synchronizing SCSI cache
[  840.497690] sd 3:0:0:0: [sdb] Stopping disk
[  841.019132] call 3:0:0:0+ returned 0 after 526386 usecs
[  841.021476] calling  target3:0:0+ @ 3651, parent: host3
[  841.023709] call target3:0:0+ returned 0 after 3 usecs
[  841.024733] calling  1:0:0:0+ @ 3651, parent: target1:0:0
[  841.025327] call 1:0:0:0+ returned 0 after 1 usecs
[  841.025907] calling  target1:0:0+ @ 3651, parent: host1
[  841.026541] call target1:0:0+ returned 0 after 0 usecs
[  841.027130] calling  0:0:0:0+ @ 3651, parent: target0:0:0
[  841.027704] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  841.029468] sd 0:0:0:0: [sda] Stopping disk
[  841.062367] call 0:0:0:0+ returned 0 after 33851 usecs
[  841.063803] calling  target0:0:0+ @ 3651, parent: host0
[  841.065206] call target0:0:0+ returned 0 after 2 usecs
[  841.066806] calling  usb4+ @ 3651, parent: 0000:04:00.0
[  841.068777] call usb4+ returned 0 after 200 usecs
[  841.070577] calling  usb3+ @ 3651, parent: 0000:04:00.0
[  841.072428] call usb3+ returned 0 after 85 usecs
[  841.074355] calling  input0+ @ 3651, parent: serio0
[  841.076143] call input0+ returned 0 after 21 usecs
[  841.078139] calling  usb2+ @ 3651, parent: 0000:00:14.0
[  841.080036] call usb2+ returned 0 after 66 usecs
[  841.081849] calling  usb1+ @ 3651, parent: 0000:00:14.0
[  841.083820] call usb1+ returned 0 after 193 usecs
[  841.085576] calling  host3+ @ 3651, parent: ata4
[  841.087357] call host3+ returned 0 after 2 usecs
[  841.089237] calling  host2+ @ 3651, parent: ata3
[  841.091052] call host2+ returned 0 after 1 usecs
[  841.092363] calling  host1+ @ 3651, parent: ata2
[  841.093639] call host1+ returned 0 after 0 usecs
[  841.094943] calling  host0+ @ 3651, parent: ata1
[  841.096199] call host0+ returned 0 after 0 usecs
[  841.097207] calling  ata4+ @ 3651, parent: 0000:00:17.0
[  841.098389] call ata4+ returned 0 after 150 usecs
[  841.099439] calling  ata3+ @ 3651, parent: 0000:00:17.0
[  841.100579] call ata3+ returned 0 after 143 usecs
[  841.101539] calling  ata2+ @ 3651, parent: 0000:00:17.0
[  841.102403] call ata2+ returned 0 after 50 usecs
[  841.103229] calling  ata1+ @ 3651, parent: 0000:00:17.0
[  841.104185] call ata1+ returned 0 after 119 usecs
[  841.105032] calling  rtsx_pci_ms.0+ @ 3651, parent: 0000:03:00.0
[  841.106005] call rtsx_pci_ms.0+ returned 0 after 72 usecs
[  841.106733] calling  rtsx_pci_sdmmc.0+ @ 3651, parent: 0000:03:00.0
[  841.107443] call rtsx_pci_sdmmc.0+ returned 0 after 1 usecs
[  841.108152] calling  serio0+ @ 3651, parent: i8042
[  841.111924] call serio0+ returned 0 after 2992 usecs
[  841.112552] calling  i8042+ @ 3651, parent: platform
[  841.113186] call i8042+ returned 0 after 1 usecs
[  841.113803] calling  microcode+ @ 3651, parent: platform
[  841.114407] call microcode+ returned 0 after 0 usecs
[  841.115031] calling  rtc0+ @ 3651, parent: 00:02
[  841.115641] call rtc0+ returned 0 after 0 usecs
[  841.116266] calling  serial8250+ @ 3651, parent: platform
[  841.116859] call serial8250+ returned 0 after 1 usecs
[  841.117408] calling  alarmtimer+ @ 3651, parent: platform
[  841.117984] call alarmtimer+ returned 0 after 0 usecs
[  841.118521] calling  efi-framebuffer.0+ @ 3651, parent: platform
[  841.119080] call efi-framebuffer.0+ returned 0 after 0 usecs
[  841.119618] calling  pcspkr+ @ 3651, parent: platform
[  841.120245] call pcspkr+ returned 0 after 10 usecs
[  841.120827] calling  00:09+ @ 3651, parent: pnp0
[  841.121379] call 00:09+ returned 0 after 1 usecs
[  841.121940] calling  00:08+ @ 3651, parent: pnp0
[  841.122479] call 00:08+ returned 0 after 0 usecs
[  841.123217] calling  00:07+ @ 3651, parent: pnp0
[  841.123771] call 00:07+ returned 0 after 0 usecs
[  841.124320] calling  00:06+ @ 3651, parent: pnp0
[  841.124858] call 00:06+ returned 0 after 0 usecs
[  841.125408] calling  00:05+ @ 3651, parent: pnp0
[  841.125955] call 00:05+ returned 0 after 1 usecs
[  841.126509] calling  00:04+ @ 3651, parent: pnp0
[  841.127159] call 00:04+ returned 0 after 0 usecs
[  841.127685] calling  00:03+ @ 3651, parent: pnp0
[  841.128225] call 00:03+ returned 0 after 0 usecs
[  841.128800] calling  00:02+ @ 3651, parent: pnp0
[  841.129472] call 00:02+ returned 0 after 83 usecs
[  841.130014] calling  00:01+ @ 3651, parent: pnp0
[  841.130550] call 00:01+ returned 0 after 0 usecs
[  841.131074] calling  00:00+ @ 3651, parent: pnp0
[  841.131602] call 00:00+ returned 0 after 0 usecs
[  841.132124] calling  LNXPWRBN:00+ @ 3651, parent: LNXSYSTM:00
[  841.132686] call LNXPWRBN:00+ returned 0 after 0 usecs
[  841.133293] calling  INT3400:00+ @ 3651, parent: platform
[  841.133864] call INT3400:00+ returned 0 after 1 usecs
[  841.134408] calling  PNP0C0E:00+ @ 3651, parent: platform
[  841.134950] call PNP0C0E:00+ returned 0 after 0 usecs
[  841.135474] calling  PNP0C0D:00+ @ 3651, parent: platform
[  841.136054] call PNP0C0D:00+ returned 0 after 0 usecs
[  841.136651] calling  ATK4002:00+ @ 3651, parent: platform
[  841.137265] call ATK4002:00+ returned 0 after 0 usecs
[  841.137799] calling  PNP0C14:01+ @ 3651, parent: platform
[  841.138347] call PNP0C14:01+ returned 0 after 0 usecs
[  841.138871] calling  MSFT0101:00+ @ 3651, parent: platform
[  841.139425] call MSFT0101:00+ returned 0 after 0 usecs
[  841.140001] calling  INT33A1:00+ @ 3651, parent: platform
[  841.140547] call INT33A1:00+ returned 0 after 0 usecs
[  841.141093] calling  ACPI000C:00+ @ 3651, parent: platform
[  841.141631] call ACPI000C:00+ returned 0 after 0 usecs
[  841.142181] calling  PNP0C14:00+ @ 3651, parent: pci0000:00
[  841.142738] call PNP0C14:00+ returned 0 after 0 usecs
[  841.143317] calling  PNP0C0A:00+ @ 3651, parent: pci0000:00
[  841.143864] call PNP0C0A:00+ returned 0 after 0 usecs
[  841.144423] calling  ACPI0003:00+ @ 3651, parent: pci0000:00
[  841.144980] call ACPI0003:00+ returned 0 after 0 usecs
[  841.145542] calling  INT3403:03+ @ 3651, parent: PNP0C09:00
[  841.146104] call INT3403:03+ returned 0 after 0 usecs
[  841.146755] calling  INT3403:02+ @ 3651, parent: PNP0C09:00
[  841.147346] call INT3403:02+ returned 0 after 1 usecs
[  841.147887] calling  INT3403:01+ @ 3651, parent: PNP0C09:00
[  841.148438] call INT3403:01+ returned 0 after 0 usecs
[  841.149086] calling  INT3403:00+ @ 3651, parent: PNP0C09:00
[  841.149677] call INT3403:00+ returned 0 after 0 usecs
[  841.150326] calling  PNP0C09:00+ @ 3651, parent: 0000:00:1f.0
[  841.150870] call PNP0C09:00+ returned 0 after 0 usecs
[  841.151420] calling  PNP0C04:00+ @ 3651, parent: 0000:00:1f.0
[  841.151958] call PNP0C04:00+ returned 0 after 0 usecs
[  841.152515] calling  PNP0103:00+ @ 3651, parent: 0000:00:1f.0
[  841.153098] call PNP0103:00+ returned 0 after 0 usecs
[  841.153653] calling  INT0800:00+ @ 3651, parent: 0000:00:1f.0
[  841.154248] call INT0800:00+ returned 0 after 0 usecs
[  841.154830] calling  0000:04:00.0+ @ 3651, parent: 0000:00:1c.4
[  841.156438] call 0000:04:00.0+ returned 0 after 1021 usecs
[  841.156998] calling  0000:03:00.1+ @ 3651, parent: 0000:00:1c.3
[  841.157829] call 0000:03:00.1+ returned 0 after 277 usecs
[  841.158379] calling  0000:03:00.0+ @ 3651, parent: 0000:00:1c.3
[  841.172676] call 0000:03:00.0+ returned 0 after 13397 usecs
[  841.173338] calling  0000:02:00.0+ @ 3651, parent: 0000:00:1c.0
[  841.174025] call 0000:02:00.0+ returned 0 after 1 usecs
[  841.174697] calling  0000:01:00.0+ @ 3651, parent: 0000:00:01.0
[  841.175447] call 0000:01:00.0+ returned 0 after 0 usecs
[  841.176167] calling  0000:00:1f.4+ @ 3651, parent: pci0000:00
[  841.177039] call 0000:00:1f.4+ returned 0 after 76 usecs
[  841.177813] calling  0000:00:1f.3+ @ 3651, parent: pci0000:00
[  841.179331] call 0000:00:1f.3+ returned 0 after 747 usecs
[  841.180094] calling  0000:00:1f.2+ @ 3651, parent: pci0000:00
[  841.180890] call 0000:00:1f.2+ returned 0 after 0 usecs
[  841.181663] calling  0000:00:1f.0+ @ 3651, parent: pci0000:00
[  841.182448] call 0000:00:1f.0+ returned 0 after 0 usecs
[  841.183224] calling  0000:00:1c.4+ @ 3651, parent: pci0000:00
[  841.184015] call 0000:00:1c.4+ returned 0 after 1 usecs
[  841.184834] calling  0000:00:1c.3+ @ 3651, parent: pci0000:00
[  841.185601] call 0000:00:1c.3+ returned 0 after 0 usecs
[  841.186391] calling  0000:00:1c.0+ @ 3651, parent: pci0000:00
[  841.187287] call 0000:00:1c.0+ returned 0 after 21 usecs
[  841.188171] calling  0000:00:17.0+ @ 3651, parent: pci0000:00
[  841.189112] call 0000:00:17.0+ returned 0 after 2 usecs
[  841.189948] calling  0000:00:16.0+ @ 3651, parent: pci0000:00
[  841.191063] call 0000:00:16.0+ returned 0 after 295 usecs
[  841.191891] calling  0000:00:15.1+ @ 3651, parent: pci0000:00
[  841.192757] call 0000:00:15.1+ returned 0 after 53 usecs
[  841.193561] calling  0000:00:15.0+ @ 3651, parent: pci0000:00
[  841.194478] call 0000:00:15.0+ returned 0 after 51 usecs
[  841.195261] calling  0000:00:14.2+ @ 3651, parent: pci0000:00
[  841.196089] call 0000:00:14.2+ returned 0 after 1 usecs
[  841.197093] calling  0000:00:14.0+ @ 3651, parent: pci0000:00
[  841.198026] call 0000:00:14.0+ returned 0 after 116 usecs
[  841.198823] calling  0000:00:04.0+ @ 3651, parent: pci0000:00
[  841.199636] call 0000:00:04.0+ returned 0 after 1 usecs
[  841.200442] calling  0000:00:02.0+ @ 3651, parent: pci0000:00
[  841.472721] call 0000:00:02.0+ returned 0 after 265116 usecs
[  841.472734] calling  0000:00:01.0+ @ 3651, parent: pci0000:00
[  841.472744] call 0000:00:01.0+ returned 0 after 3 usecs
[  841.472750] calling  0000:00:00.0+ @ 3651, parent: pci0000:00
[  841.472757] call 0000:00:00.0+ returned 0 after 2 usecs
[  841.472769] calling  LNXTHERM:00+ @ 3651, parent: LNXSYBUS:01
[  841.472778] call LNXTHERM:00+ returned 0 after 3 usecs
[  841.472790] calling  PNP0C0E:00+ @ 3651, parent: LNXSYBUS:00
[  841.472797] call PNP0C0E:00+ returned 0 after 1 usecs
[  841.472802] calling  PNP0C0D:00+ @ 3651, parent: LNXSYBUS:00
[  841.472808] call PNP0C0D:00+ returned 0 after 1 usecs
[  841.472916] calling  PNP0C09:00+ @ 3651, parent: device:45
[  841.472923] ACPI : EC: event blocked
[  841.472929] call PNP0C09:00+ returned 0 after 7 usecs
[  841.473183] PM: suspend of devices complete after 1146.299 msecs
[  841.473203] calling  i2c-ELAN1000:00+ @ 3651, parent: i2c-7
[  841.473211] call i2c-ELAN1000:00+ returned 0 after 3 usecs
[  841.473529] calling  INT3400:00+ @ 3651, parent: platform
[  841.473537] call INT3400:00+ returned 0 after 2 usecs
[  841.473548] calling  INT3403:03+ @ 3651, parent: PNP0C09:00
[  841.473555] call INT3403:03+ returned 0 after 1 usecs
[  841.473560] calling  INT3403:02+ @ 3651, parent: PNP0C09:00
[  841.473567] call INT3403:02+ returned 0 after 1 usecs
[  841.473572] calling  INT3403:01+ @ 3651, parent: PNP0C09:00
[  841.473578] call INT3403:01+ returned 0 after 1 usecs
[  841.473583] calling  INT3403:00+ @ 3651, parent: PNP0C09:00
[  841.473589] call INT3403:00+ returned 0 after 1 usecs
[  841.473619] calling  0000:00:02.0+ @ 3651, parent: pci0000:00
[  841.489227] call 0000:00:02.0+ returned 0 after 15236 usecs
[  841.489505] PM: late suspend of devices complete after 16.314 msecs
[  841.489776] calling  iTCO_wdt+ @ 3651, parent: 0000:00:1f.4
[  841.489793] call iTCO_wdt+ returned 0 after 5 usecs
[  841.490062] calling  0000:04:00.0+ @ 3651, parent: 0000:00:1c.4
[  841.490181] xhci_hcd 0000:04:00.0: System wakeup enabled by ACPI
[  841.505851] call 0000:04:00.0+ returned 0 after 15413 usecs
[  841.505858] calling  0000:03:00.1+ @ 3651, parent: 0000:00:1c.3
[  841.505927] pcieport 0000:00:1c.3: System wakeup enabled by ACPI
[  841.522776] call 0000:03:00.1+ returned 0 after 16516 usecs
[  841.522782] calling  0000:03:00.0+ @ 3651, parent: 0000:00:1c.3
[  841.522789] call 0000:03:00.0+ returned 0 after 2 usecs
[  841.522796] calling  0000:02:00.0+ @ 3651, parent: 0000:00:1c.0
[  841.539289] call 0000:02:00.0+ returned 0 after 16102 usecs
[  841.539296] calling  0000:01:00.0+ @ 3651, parent: 0000:00:01.0
[  841.539352] call 0000:01:00.0+ returned 0 after 49 usecs
[  841.539359] calling  0000:00:1f.4+ @ 3651, parent: pci0000:00
[  841.539423] call 0000:00:1f.4+ returned 0 after 58 usecs
[  841.539429] calling  0000:00:1f.3+ @ 3651, parent: pci0000:00
[  841.555796] call 0000:00:1f.3+ returned 0 after 15979 usecs
[  841.555803] calling  0000:00:1f.2+ @ 3651, parent: pci0000:00
[  841.555835] call 0000:00:1f.2+ returned 0 after 27 usecs
[  841.555841] calling  0000:00:1f.0+ @ 3651, parent: pci0000:00
[  841.555885] call 0000:00:1f.0+ returned 0 after 38 usecs
[  841.555890] calling  0000:00:1c.4+ @ 3651, parent: pci0000:00
[  841.572460] call 0000:00:1c.4+ returned 0 after 16177 usecs
[  841.572466] calling  0000:00:1c.3+ @ 3651, parent: pci0000:00
[  841.589125] call 0000:00:1c.3+ returned 0 after 16264 usecs
[  841.589132] calling  0000:00:1c.0+ @ 3651, parent: pci0000:00
[  841.605792] call 0000:00:1c.0+ returned 0 after 16265 usecs
[  841.605798] calling  0000:00:17.0+ @ 3651, parent: pci0000:00
[  841.622457] call 0000:00:17.0+ returned 0 after 16264 usecs
[  841.622464] calling  0000:00:16.0+ @ 3651, parent: pci0000:00
[  841.639125] call 0000:00:16.0+ returned 0 after 16267 usecs
[  841.639132] calling  0000:00:15.1+ @ 3651, parent: pci0000:00
[  841.656143] call 0000:00:15.1+ returned 0 after 16608 usecs
[  841.656153] calling  0000:00:15.0+ @ 3651, parent: pci0000:00
[  841.672781] call 0000:00:15.0+ returned 0 after 16233 usecs
[  841.672790] calling  0000:00:14.2+ @ 3651, parent: pci0000:00
[  841.689123] call 0000:00:14.2+ returned 0 after 15946 usecs
[  841.689130] calling  0000:00:14.0+ @ 3651, parent: pci0000:00
[  841.706364] call 0000:00:14.0+ returned 0 after 16825 usecs
[  841.706373] calling  0000:00:04.0+ @ 3651, parent: pci0000:00
[  841.706401] call 0000:00:04.0+ returned 0 after 22 usecs
[  841.706407] calling  0000:00:02.0+ @ 3651, parent: pci0000:00
[  841.706414] call 0000:00:02.0+ returned 0 after 2 usecs
[  841.706419] calling  0000:00:01.0+ @ 3651, parent: pci0000:00
[  841.777125] call 0000:00:01.0+ returned 0 after 69045 usecs
[  841.777135] calling  0000:00:00.0+ @ 3651, parent: pci0000:00
[  841.777162] call 0000:00:00.0+ returned 0 after 21 usecs
[  841.777245] calling  PNP0C09:00+ @ 3651, parent: device:45
[  841.777252] ACPI : EC: interrupt blocked
[  841.777257] call PNP0C09:00+ returned 0 after 6 usecs
[  841.777434] PM: noirq suspend of devices complete after 287.883 msecs
[  841.777445] PM: suspend-to-idle
[  852.771973] Suspended for 10.993 seconds
[  852.772094] PM: resume from suspend-to-idle
[  852.772309] calling  PNP0C09:00+ @ 3651, parent: device:45
[  852.772322] ACPI : EC: interrupt unblocked
[  852.772328] call PNP0C09:00+ returned 0 after 8 usecs
[  852.772364] calling  0000:00:00.0+ @ 3651, parent: pci0000:00
[  852.772396] call 0000:00:00.0+ returned 0 after 25 usecs
[  852.772401] calling  0000:00:01.0+ @ 3651, parent: pci0000:00
[  852.940384] call 0000:00:01.0+ returned 0 after 164049 usecs
[  852.940387] calling  0000:00:02.0+ @ 3651, parent: pci0000:00
[  852.956856] call 0000:00:02.0+ returned 0 after 16081 usecs
[  852.956859] calling  0000:00:04.0+ @ 3651, parent: pci0000:00
[  852.956875] call 0000:00:04.0+ returned 0 after 13 usecs
[  852.956878] calling  0000:00:14.0+ @ 3651, parent: pci0000:00
[  852.973549] call 0000:00:14.0+ returned 0 after 16277 usecs
[  852.973556] calling  0000:00:14.2+ @ 3651, parent: pci0000:00
[  852.990204] call 0000:00:14.2+ returned 0 after 16254 usecs
[  852.990210] calling  0000:00:15.0+ @ 3651, parent: pci0000:00
[  853.007010] call 0000:00:15.0+ returned 0 after 16401 usecs
[  853.007017] calling  0000:00:15.1+ @ 3651, parent: pci0000:00
[  853.023669] call 0000:00:15.1+ returned 0 after 16256 usecs
[  853.023677] calling  0000:00:16.0+ @ 3651, parent: pci0000:00
[  853.040207] call 0000:00:16.0+ returned 0 after 16138 usecs
[  853.040213] calling  0000:00:17.0+ @ 3651, parent: pci0000:00
[  853.056875] call 0000:00:17.0+ returned 0 after 16267 usecs
[  853.056881] calling  0000:00:1c.0+ @ 3651, parent: pci0000:00
[  853.073538] call 0000:00:1c.0+ returned 0 after 16263 usecs
[  853.073544] calling  0000:00:1c.3+ @ 3651, parent: pci0000:00
[  853.090203] call 0000:00:1c.3+ returned 0 after 16264 usecs
[  853.090209] calling  0000:00:1c.4+ @ 3651, parent: pci0000:00
[  853.106866] call 0000:00:1c.4+ returned 0 after 16263 usecs
[  853.106872] calling  0000:00:1f.0+ @ 3651, parent: pci0000:00
[  853.106920] call 0000:00:1f.0+ returned 0 after 42 usecs
[  853.106925] calling  0000:00:1f.2+ @ 3651, parent: pci0000:00
[  853.106960] call 0000:00:1f.2+ returned 0 after 28 usecs
[  853.106965] calling  0000:00:1f.3+ @ 3651, parent: pci0000:00
[  853.123533] call 0000:00:1f.3+ returned 0 after 16175 usecs
[  853.123539] calling  0000:00:1f.4+ @ 3651, parent: pci0000:00
[  853.123606] call 0000:00:1f.4+ returned 0 after 61 usecs
[  853.123612] calling  0000:01:00.0+ @ 3651, parent: 0000:00:01.0
[  853.123722] call 0000:01:00.0+ returned 0 after 103 usecs
[  853.123728] calling  0000:02:00.0+ @ 3651, parent: 0000:00:1c.0
[  853.140490] call 0000:02:00.0+ returned 0 after 16364 usecs
[  853.140497] calling  0000:03:00.0+ @ 3651, parent: 0000:00:1c.3
[  853.156905] call 0000:03:00.0+ returned 0 after 16020 usecs
[  853.156911] calling  0000:03:00.1+ @ 3651, parent: 0000:00:1c.3
[  853.173564] call 0000:03:00.1+ returned 0 after 16258 usecs
[  853.173570] calling  0000:04:00.0+ @ 3651, parent: 0000:00:1c.4
[  853.190271] xhci_hcd 0000:04:00.0: System wakeup disabled by ACPI
[  853.190342] call 0000:04:00.0+ returned 0 after 16374 usecs
[  853.190409] calling  i8042+ @ 3651, parent: platform
[  853.190422] call i8042+ returned 0 after 8 usecs
[  853.190490] calling  iTCO_wdt+ @ 3651, parent: 0000:00:1f.4
[  853.190498] call iTCO_wdt+ returned 0 after 2 usecs
[  853.190537] PM: noirq resume of devices complete after 418.374 msecs
[  853.190917] calling  0000:00:02.0+ @ 3651, parent: pci0000:00
[  853.191203] call 0000:00:02.0+ returned 0 after 274 usecs
[  853.191225] calling  INT3403:00+ @ 3651, parent: PNP0C09:00
[  853.191232] call INT3403:00+ returned 0 after 2 usecs
[  853.191237] calling  INT3403:01+ @ 3651, parent: PNP0C09:00
[  853.191243] call INT3403:01+ returned 0 after 1 usecs
[  853.191248] calling  INT3403:02+ @ 3651, parent: PNP0C09:00
[  853.191255] call INT3403:02+ returned 0 after 1 usecs
[  853.191259] calling  INT3403:03+ @ 3651, parent: PNP0C09:00
[  853.191265] call INT3403:03+ returned 0 after 1 usecs
[  853.191276] calling  INT3400:00+ @ 3651, parent: platform
[  853.191282] call INT3400:00+ returned 0 after 1 usecs
[  853.191469] calling  i2c-ELAN1000:00+ @ 3651, parent: i2c-7
[  853.191477] call i2c-ELAN1000:00+ returned 0 after 2 usecs
[  853.191489] PM: early resume of devices complete after 0.769 msecs
[  853.191634] calling  PNP0C09:00+ @ 3651, parent: device:45
[  853.191640] ACPI : EC: event unblocked
[  853.191658] call PNP0C09:00+ returned 0 after 18 usecs
[  853.191692] calling  ACPI0003:00+ @ 3651, parent: PNP0A08:00
[  853.191766] call ACPI0003:00+ returned 0 after 68 usecs
[  853.191773] calling  PNP0C0A:00+ @ 3651, parent: PNP0A08:00
[  853.191842] call PNP0C0A:00+ returned 0 after 62 usecs
[  853.191855] calling  PNP0C0D:00+ @ 3651, parent: LNXSYBUS:00
[  853.191863] call PNP0C0D:00+ returned 0 after 3 usecs
[  853.191868] calling  PNP0C0E:00+ @ 3651, parent: LNXSYBUS:00
[  853.191874] call PNP0C0E:00+ returned 0 after 1 usecs
[  853.191882] calling  LNXTHERM:00+ @ 3651, parent: LNXSYBUS:01
[  853.191901] call LNXTHERM:00+ returned 0 after 13 usecs
[  853.191908] calling  0000:00:00.0+ @ 3651, parent: pci0000:00
[  853.191916] call 0000:00:00.0+ returned 0 after 3 usecs
[  853.191921] calling  0000:00:01.0+ @ 3651, parent: pci0000:00
[  853.191929] call 0000:00:01.0+ returned 0 after 2 usecs
[  853.191934] calling  0000:00:02.0+ @ 3651, parent: pci0000:00
[  853.199017] [drm] GuC firmware load skipped
[  853.466535] call 0000:00:02.0+ returned 0 after 268173 usecs
[  853.467226] calling  0000:00:04.0+ @ 3651, parent: pci0000:00
[  853.467944] call 0000:00:04.0+ returned 0 after 3 usecs
[  853.468610] calling  0000:00:14.0+ @ 3651, parent: pci0000:00
[  853.469499] call 0000:00:14.0+ returned 0 after 159 usecs
[  853.470205] calling  0000:00:14.2+ @ 3651, parent: pci0000:00
[  853.470876] call 0000:00:14.2+ returned 0 after 1 usecs
[  853.471538] calling  0000:00:15.0+ @ 3651, parent: pci0000:00
[  853.472210] call 0000:00:15.0+ returned 0 after 4 usecs
[  853.472879] calling  0000:00:15.1+ @ 3651, parent: pci0000:00
[  853.473558] call 0000:00:15.1+ returned 0 after 4 usecs
[  853.474261] calling  0000:00:16.0+ @ 3651, parent: pci0000:00
[  853.475902] call 0000:00:16.0+ returned 0 after 956 usecs
[  853.476584] calling  0000:00:17.0+ @ 3651, parent: pci0000:00
[  853.477300] call 0000:00:17.0+ returned 0 after 32 usecs
[  853.477975] calling  0000:00:1c.0+ @ 3651, parent: pci0000:00
[  853.478654] call 0000:00:1c.0+ returned 0 after 1 usecs
[  853.479324] calling  0000:00:1c.3+ @ 3651, parent: pci0000:00
[  853.480011] call 0000:00:1c.3+ returned 0 after 0 usecs
[  853.480709] calling  0000:00:1c.4+ @ 3651, parent: pci0000:00
[  853.481398] call 0000:00:1c.4+ returned 0 after 0 usecs
[  853.482057] calling  0000:00:1f.0+ @ 3651, parent: pci0000:00
[  853.482763] call 0000:00:1f.0+ returned 0 after 0 usecs
[  853.483536] calling  0000:00:1f.2+ @ 3651, parent: pci0000:00
[  853.484253] call 0000:00:1f.2+ returned 0 after 0 usecs
[  853.484924] calling  0000:00:1f.3+ @ 3651, parent: pci0000:00
[  853.499767] call 0000:00:1f.3+ returned 0 after 13814 usecs
[  853.502130] calling  0000:00:1f.4+ @ 3651, parent: pci0000:00
[  853.504651] call 0000:00:1f.4+ returned 0 after 20 usecs
[  853.507133] calling  0000:01:00.0+ @ 3651, parent: 0000:00:01.0
[  853.509479] call 0000:01:00.0+ returned 0 after 3 usecs
[  853.510782] calling  0000:02:00.0+ @ 3651, parent: 0000:00:1c.0
[  853.511628] call 0000:02:00.0+ returned 0 after 157 usecs
[  853.512283] calling  0000:03:00.0+ @ 3651, parent: 0000:00:1c.3
[  853.513228] call 0000:03:00.0+ returned 0 after 279 usecs
[  853.513865] calling  0000:03:00.1+ @ 3651, parent: 0000:00:1c.3
[  853.514537] pcieport 0000:00:1c.3: System wakeup disabled by ACPI
[  853.532744] r8169 0000:03:00.1 enp3s0f1: link down
[  853.533476] call 0000:03:00.1+ returned 0 after 18502 usecs
[  853.534176] calling  0000:04:00.0+ @ 3651, parent: 0000:00:1c.4
[  853.534936] usb usb3: root hub lost power or was reset
[  853.535594] usb usb4: root hub lost power or was reset
[  853.595724] call 0000:04:00.0+ returned 0 after 59423 usecs
[  853.596341] calling  INT0800:00+ @ 3651, parent: 0000:00:1f.0
[  853.596973] call INT0800:00+ returned 0 after 0 usecs
[  853.597637] calling  PNP0103:00+ @ 3651, parent: 0000:00:1f.0
[  853.598258] call PNP0103:00+ returned 0 after 0 usecs
[  853.598903] calling  PNP0C04:00+ @ 3651, parent: 0000:00:1f.0
[  853.599511] call PNP0C04:00+ returned 0 after 0 usecs
[  853.600132] calling  PNP0C09:00+ @ 3651, parent: 0000:00:1f.0
[  853.600818] call PNP0C09:00+ returned 0 after 0 usecs
[  853.601424] calling  ACPI0003:00+ @ 3651, parent: pci0000:00
[  853.602042] call ACPI0003:00+ returned 0 after 0 usecs
[  853.602670] calling  PNP0C0A:00+ @ 3651, parent: pci0000:00
[  853.603283] call PNP0C0A:00+ returned 0 after 0 usecs
[  853.603885] calling  PNP0C14:00+ @ 3651, parent: pci0000:00
[  853.604565] call PNP0C14:00+ returned 0 after 0 usecs
[  853.605185] calling  ACPI000C:00+ @ 3651, parent: platform
[  853.605785] call ACPI000C:00+ returned 0 after 0 usecs
[  853.606405] calling  INT33A1:00+ @ 3651, parent: platform
[  853.607109] call INT33A1:00+ returned 0 after 0 usecs
[  853.607830] calling  MSFT0101:00+ @ 3651, parent: platform
[  853.608435] call MSFT0101:00+ returned 0 after 1 usecs
[  853.609052] calling  PNP0C14:01+ @ 3651, parent: platform
[  853.609701] call PNP0C14:01+ returned 0 after 0 usecs
[  853.610350] calling  ATK4002:00+ @ 3651, parent: platform
[  853.610989] call ATK4002:00+ returned 0 after 0 usecs
[  853.611642] calling  PNP0C0D:00+ @ 3651, parent: platform
[  853.612325] call PNP0C0D:00+ returned 0 after 0 usecs
[  853.612962] calling  PNP0C0E:00+ @ 3651, parent: platform
[  853.613574] call PNP0C0E:00+ returned 0 after 0 usecs
[  853.614226] calling  LNXPWRBN:00+ @ 3651, parent: LNXSYSTM:00
[  853.614834] call LNXPWRBN:00+ returned 0 after 0 usecs
[  853.615553] calling  00:00+ @ 3651, parent: pnp0
[  853.616141] call 00:00+ returned 0 after 0 usecs
[  853.616747] calling  00:01+ @ 3651, parent: pnp0
[  853.617409] call 00:01+ returned 0 after 0 usecs
[  853.618057] calling  00:02+ @ 3651, parent: pnp0
[  853.618656] rtc_cmos 00:02: System wakeup disabled by ACPI
[  853.619572] call 00:02+ returned 0 after 892 usecs
[  853.620300] calling  00:03+ @ 3651, parent: pnp0
[  853.620941] call 00:03+ returned 0 after 0 usecs
[  853.621518] calling  00:04+ @ 3651, parent: pnp0
[  853.622187] call 00:04+ returned 0 after 0 usecs
[  853.622773] calling  00:05+ @ 3651, parent: pnp0
[  853.623348] call 00:05+ returned 0 after 0 usecs
[  853.623940] calling  00:06+ @ 3651, parent: pnp0
[  853.624594] call 00:06+ returned 0 after 0 usecs
[  853.625266] calling  00:07+ @ 3651, parent: pnp0
[  853.625840] call 00:07+ returned 0 after 0 usecs
[  853.626472] calling  00:08+ @ 3651, parent: pnp0
[  853.627067] call 00:08+ returned 0 after 0 usecs
[  853.627709] calling  00:09+ @ 3651, parent: pnp0
[  853.628294] call 00:09+ returned 0 after 0 usecs
[  853.628905] calling  pcspkr+ @ 3651, parent: platform
[  853.629461] call pcspkr+ returned 0 after 0 usecs
[  853.630039] calling  efi-framebuffer.0+ @ 3651, parent: platform
[  853.630618] call efi-framebuffer.0+ returned 0 after 0 usecs
[  853.631214] calling  alarmtimer+ @ 3651, parent: platform
[  853.631863] call alarmtimer+ returned 0 after 0 usecs
[  853.632433] calling  serial8250+ @ 3651, parent: platform
[  853.632996] call serial8250+ returned 0 after 0 usecs
[  853.633596] calling  rtc0+ @ 3651, parent: 00:02
[  853.634258] call rtc0+ returned 0 after 1 usecs
[  853.634892] calling  microcode+ @ 3651, parent: platform
[  853.635501] call microcode+ returned 0 after 0 usecs
[  853.636060] calling  i8042+ @ 3651, parent: platform
[  853.636638] call i8042+ returned 0 after 0 usecs
[  853.637258] calling  serio0+ @ 3651, parent: i8042
[  853.637874] call serio0+ returned 0 after 15 usecs
[  853.638458] calling  rtsx_pci_sdmmc.0+ @ 3651, parent: 0000:03:00.0
[  853.639002] call rtsx_pci_sdmmc.0+ returned 0 after 0 usecs
[  853.639558] calling  rtsx_pci_ms.0+ @ 3651, parent: 0000:03:00.0
[  853.640123] call rtsx_pci_ms.0+ returned 0 after 2 usecs
[  853.640753] calling  ata1+ @ 3651, parent: 0000:00:17.0
[  853.641326] call ata1+ returned 0 after 2 usecs
[  853.641938] calling  ata2+ @ 3651, parent: 0000:00:17.0
[  853.642543] call ata2+ returned 0 after 1 usecs
[  853.643186] calling  ata3+ @ 3651, parent: 0000:00:17.0
[  853.643831] call ata3+ returned 0 after 0 usecs
[  853.644514] calling  ata4+ @ 3651, parent: 0000:00:17.0
[  853.645111] call ata4+ returned 0 after 2 usecs
[  853.645675] calling  host0+ @ 3651, parent: ata1
[  853.646225] call host0+ returned 0 after 0 usecs
[  853.646759] calling  host1+ @ 3651, parent: ata2
[  853.647350] call host1+ returned 0 after 0 usecs
[  853.647945] calling  host2+ @ 3651, parent: ata3
[  853.648481] call host2+ returned 0 after 0 usecs
[  853.649061] calling  host3+ @ 3651, parent: ata4
[  853.649587] call host3+ returned 0 after 0 usecs
[  853.650127] calling  usb1+ @ 3651, parent: 0000:00:14.0
[  853.708108] call usb1+ returned 0 after 56038 usecs
[  853.709847] calling  usb2+ @ 3651, parent: 0000:00:14.0
[  853.711686] call usb2+ returned 0 after 61 usecs
[  853.713712] calling  input0+ @ 3651, parent: serio0
[  853.715733] call input0+ returned 0 after 22 usecs
[  853.717735] calling  usb3+ @ 3651, parent: 0000:04:00.0
[  853.823635] call usb3+ returned 0 after 101402 usecs
[  853.825626] calling  usb4+ @ 3651, parent: 0000:04:00.0
[  853.933668] call usb4+ returned 0 after 103555 usecs
[  853.935713] calling  target0:0:0+ @ 3651, parent: host0
[  853.937737] call target0:0:0+ returned 0 after 4 usecs
[  853.939756] calling  0:0:0:0+ @ 3651, parent: target0:0:0
[  853.941866] call 0:0:0:0+ returned 0 after 6 usecs
[  853.941929] sd 0:0:0:0: [sda] Starting disk
[  853.946066] calling  target1:0:0+ @ 3651, parent: host1
[  853.948076] call target1:0:0+ returned 0 after 2 usecs
[  853.950114] calling  1:0:0:0+ @ 3651, parent: target1:0:0
[  853.952207] call 1:0:0:0+ returned 0 after 6 usecs
[  853.954212] calling  target3:0:0+ @ 3651, parent: host3
[  853.954310] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[  853.957728] ata3: SATA link down (SStatus 4 SControl 300)
[  853.957953] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[  853.962336] ata1.00: configured for UDMA/133
[  853.963103] ata2.00: configured for UDMA/133
[  853.966526] call target3:0:0+ returned 0 after 2 usecs
[  853.967489] ata4: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[  853.969984] ata4.00: configured for UDMA/133
[  853.971586] calling  3:0:0:0+ @ 3651, parent: target3:0:0
[  853.972731] call 3:0:0:0+ returned 0 after 4 usecs
[  853.972737] sd 3:0:0:0: [sdb] Starting disk
[  853.974975] calling  1-1+ @ 3651, parent: usb1
[  853.976479] call 1-1+ returned 0 after 386 usecs
[  853.977609] calling  input1+ @ 3651, parent: 0003:093A:2510.0001
[  853.978731] call input1+ returned 0 after 1 usecs
[  853.979863] calling  1-4+ @ 3651, parent: usb1
[  854.090751] call 1-4+ returned 0 after 107191 usecs
[  854.092855] calling  1-9+ @ 3651, parent: usb1
[  854.095219] call 1-9+ returned 0 after 248 usecs
[  854.097507] calling  vboxdrv.0+ @ 3651, parent: platform
[  854.099592] call vboxdrv.0+ returned 0 after 5 usecs
[  854.101689] calling  input2+ @ 3651, parent: PNP0C0D:00
[  854.103777] call input2+ returned 0 after 2 usecs
[  854.105967] calling  input3+ @ 3651, parent: PNP0C0E:00
[  854.108082] call input3+ returned 0 after 2 usecs
[  854.110178] calling  input4+ @ 3651, parent: LNXPWRBN:00
[  854.112278] call input4+ returned 0 after 2 usecs
[  854.114355] calling  input5+ @ 3651, parent: ATK4002:00
[  854.116424] call input5+ returned 0 after 1 usecs
[  854.118502] calling  asus-wireless::airplane+ @ 3651, parent: ATK4002:00
[  854.120573] call asus-wireless::airplane+ returned 0 after 9 usecs
[  854.123187] calling  input6+ @ 3651, parent: pcspkr
[  854.125320] call input6+ returned 0 after 26 usecs
[  854.127535] calling  input0::numlock+ @ 3651, parent: input0
[  854.129637] call input0::numlock+ returned 0 after 2 usecs
[  854.131663] calling  input0::capslock+ @ 3651, parent: input0
[  854.133124] call input0::capslock+ returned 0 after 1 usecs
[  854.134628] calling  input0::scrolllock+ @ 3651, parent: input0
[  854.136081] call input0::scrolllock+ returned 0 after 1 usecs
[  854.137257] calling  idma64.0+ @ 3651, parent: 0000:00:15.0
[  854.138397] call idma64.0+ returned 0 after 2 usecs
[  854.139567] calling  i2c_designware.0+ @ 3651, parent: 0000:00:15.0
[  854.140745] call i2c_designware.0+ returned 0 after 7 usecs
[  854.141834] calling  idma64.1+ @ 3651, parent: 0000:00:15.1
[  854.142804] call idma64.1+ returned 0 after 2 usecs
[  854.143758] calling  i2c_designware.1+ @ 3651, parent: 0000:00:15.1
[  854.144709] call i2c_designware.1+ returned 0 after 6 usecs
[  854.145649] calling  iTCO_wdt+ @ 3651, parent: 0000:00:1f.4
[  854.146539] call iTCO_wdt+ returned 0 after 0 usecs
[  854.147331] calling  regulatory.0+ @ 3651, parent: platform
[  854.148002] call regulatory.0+ returned 0 after 0 usecs
[  854.148583] calling  rfkill0+ @ 3651, parent: hci0
[  854.149174] call rfkill0+ returned 0 after 1 usecs
[  854.149798] calling  asus-nb-wmi+ @ 3651, parent: platform
[  854.150416] call asus-nb-wmi+ returned 0 after 1 usecs
[  854.152312] calling  input7+ @ 3651, parent: asus-nb-wmi
[  854.152953] call input7+ returned 0 after 0 usecs
[  854.153611] calling  coretemp.0+ @ 3651, parent: platform
[  854.154264] call coretemp.0+ returned 0 after 0 usecs
[  854.154954] calling  asus::kbd_backlight+ @ 3651, parent: asus-nb-wmi
[  854.155636] call asus::kbd_backlight+ returned 0 after 0 usecs
[  854.156301] calling  input8+ @ 3651, parent: 1-4:1.0
[  854.156983] call input8+ returned 0 after 0 usecs
[  854.157688] calling  intel_backlight+ @ 3651, parent: card0-eDP-1
[  854.158402] call intel_backlight+ returned 0 after 1 usecs
[  854.159168] calling  input9+ @ 3651, parent: LNXVIDEO:00
[  854.159827] call input9+ returned 0 after 0 usecs
[  854.160504] calling  input10+ @ 3651, parent: LNXVIDEO:01
[  854.161168] call input10+ returned 0 after 0 usecs
[  854.161831] calling  phy0-led+ @ 3651, parent: 0000:02:00.0
[  854.162483] call phy0-led+ returned 0 after 0 usecs
[  854.163215] calling  phy0+ @ 3651, parent: 0000:02:00.0
[  854.166905] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  854.168046] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  854.237138] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  854.239874] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  854.274536] call phy0+ returned 0 after 108123 usecs
[  854.276727] calling  rfkill1+ @ 3651, parent: phy0
[  854.279289] call rfkill1+ returned 0 after 5 usecs
[  854.281481] calling  hdaudioC0D0+ @ 3651, parent: 0000:00:1f.3
[  854.284957] call hdaudioC0D0+ returned 0 after 1292 usecs
[  854.287344] calling  hdaudioC0D2+ @ 3651, parent: 0000:00:1f.3
[  854.289591] call hdaudioC0D2+ returned 0 after 6 usecs
[  854.291814] calling  input11+ @ 3651, parent: card0
[  854.294155] call input11+ returned 0 after 2 usecs
[  854.296320] calling  input12+ @ 3651, parent: card0
[  854.298497] call input12+ returned 0 after 1 usecs
[  854.300657] calling  input13+ @ 3651, parent: card0
[  854.303031] call input13+ returned 0 after 1 usecs
[  854.305211] calling  input14+ @ 3651, parent: card0
[  854.307394] call input14+ returned 0 after 1 usecs
[  854.309586] calling  i2c-ELAN1000:00+ @ 3651, parent: i2c-7
[  854.637189] call i2c-ELAN1000:00+ returned 0 after 317649 usecs
[  854.639413] calling  input15+ @ 3651, parent: i2c-ELAN1000:00
[  854.641600] call input15+ returned 0 after 3 usecs
[  854.642712] PM: resume of devices complete after 1451.293 msecs
[  854.644166] PM: Finishing wakeup.
[  854.644738] Restarting tasks ... done.
[  854.746368] [drm] RC6 off
[  854.836926] wlp2s0: authenticate with 32:91:8f:ca:f1:a3
[  854.841201] wlp2s0: send auth to 32:91:8f:ca:f1:a3 (try 1/3)
[  854.842952] wlp2s0: authenticated
[  854.844363] wlp2s0: associate with 32:91:8f:ca:f1:a3 (try 1/3)
[  854.845605] wlp2s0: RX AssocResp from 32:91:8f:ca:f1:a3 (capab=0x11 status=0 aid=2)
[  854.846848] wlp2s0: associated
[  854.922879] wlp2s0: Limiting TX power to 27 (27 - 0) dBm as advertised by 32:91:8f:ca:f1:a3

Should I open a bug?

I'm still learning English so please excuse me if my English is not good enough and feel free to correct me via PM if you want.

Offline

Pages: 1

Board footer

Powered by FluxBB