Sample Header Ad - 728x90

Cause of abnormal laptop shutdown? Could ACPI Errors cause Overheating?

0 votes
1 answer
110 views
My well cooled laptop surprisingly shutdown at about 5 am local time, when I was sleeping. If anyone could help me decipher from logs or whatever below, what was the real cause, I would appreciate it very much. I attach some minimalistic hw info + log. Yeah, I saw *critical temperature* in the log, but it has to be mistake or something. My laptop never overheats... Well, let's suppose it has been caused by overheating, for the sake of argument, what could have caused it? **Could those ACPI Errors cause Overheating?** The laptop had no reason to overheat, now exactly same VPN+torrents are running, and this is what sensors show:
coretemp-isa-0000
Adapter: ISA adapter
Package id 0:  +52.0°C  (high = +100.0°C, crit = +100.0°C)
Core 0:        +51.0°C  (high = +100.0°C, crit = +100.0°C)
Core 1:        +52.0°C  (high = +100.0°C, crit = +100.0°C)
Core 2:        +50.0°C  (high = +100.0°C, crit = +100.0°C)
Core 3:        +49.0°C  (high = +100.0°C, crit = +100.0°C)

dell_smm-isa-0000
Adapter: ISA adapter
Processor Fan:    0 RPM  (min =    0 RPM, max = 4900 RPM)
Video Fan:        0 RPM  (min =    0 RPM, max = 4900 RPM)
CPU:            +54.0°C  
Ambient:        +51.0°C  
SODIMM:         +38.0°C  
Other:          +47.0°C  
GPU:            +52.0°C  

ucsi_source_psy_USBC000:001-isa-0000
Adapter: ISA adapter
in0:           5.00 V  (min =  +5.00 V, max =  +5.00 V)
curr1:         0.00 A  (max =  +0.00 A)

BAT0-acpi-0
Adapter: ACPI interface
in0:          17.34 V  
curr1:       1000.00 uA 

iwlwifi_1-virtual-0
Adapter: Virtual device
temp1:            N/A  

pch_skylake-virtual-0
Adapter: Virtual device
temp1:        +47.0°C  

nvme-pci-3d00
Adapter: PCI adapter
Composite:    +35.9°C  (low  =  -0.1°C, high = +84.8°C)
                       (crit = +94.8°C)
Sensor 1:     +35.9°C  (low  = -273.1°C, high = +65261.8°C)
Sensor 2:     +34.9°C  (low  = -273.1°C, high = +65261.8°C)
Sensor 8:     +35.9°C  (low  = -273.1°C, high = +65261.8°C)

acpitz-acpi-0
Adapter: ACPI interface
temp1:        +25.0°C
The only thigs that were running: de Cinnamon, vpn with its gui, and Transmission torrent client downloading stuff to my NAS (NFSv4.1). My laptop is Dell 7577 (cpu i7-7700hq, ram 32gb ddr4, ssd sata samsung), kernel 6.8.0-45-generic, Linux Mint 22 Cinnamon (64bit, uefi):
Oct 09 00:00:01 systemd: Starting dpkg-db-backup.service - Daily dpkg database backup service...
Oct 09 00:00:01 systemd: Starting logrotate.service - Rotate log files...
Oct 09 00:00:01 systemd: Stopping cups-browsed.service - Make remote CUPS printers available locally...
Oct 09 00:00:01 systemd: cups-browsed.service: Deactivated successfully.
Oct 09 00:00:01 systemd: Stopped cups-browsed.service - Make remote CUPS printers available locally.
Oct 09 00:00:01 systemd: Stopping cups.service - CUPS Scheduler...
Oct 09 00:00:01 systemd: cups.service: Deactivated successfully.
Oct 09 00:00:01 systemd: Stopped cups.service - CUPS Scheduler.
Oct 09 00:00:01 systemd: cups.path: Deactivated successfully.
Oct 09 00:00:01 systemd: Stopped cups.path - CUPS Scheduler.
Oct 09 00:00:01 systemd: Stopping cups.path - CUPS Scheduler...
Oct 09 00:00:01 systemd: Started cups.path - CUPS Scheduler.
Oct 09 00:00:01 systemd: cups.socket: Deactivated successfully.
Oct 09 00:00:01 systemd: Closed cups.socket - CUPS Scheduler.
Oct 09 00:00:01 systemd: Stopping cups.socket - CUPS Scheduler...
Oct 09 00:00:01 systemd: Listening on cups.socket - CUPS Scheduler.
Oct 09 00:00:01 systemd: Starting cups.service - CUPS Scheduler...
Oct 09 00:00:01 systemd: Started cups.service - CUPS Scheduler.
Oct 09 00:00:01 systemd: Started cups-browsed.service - Make remote CUPS printers available locally.
Oct 09 00:00:01 systemd: logrotate.service: Deactivated successfully.
Oct 09 00:00:01 systemd: Finished logrotate.service - Rotate log files.
Oct 09 00:00:01 systemd: dpkg-db-backup.service: Deactivated successfully.
Oct 09 00:00:01 systemd: Finished dpkg-db-backup.service - Daily dpkg database backup service.
Oct 09 00:00:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 00:00:01 CRON: (root) CMD (timeshift --check --scripted)
Oct 09 00:00:02 crontab: (root) LIST (root)
Oct 09 00:00:02 crontab: (root) LIST (root)
Oct 09 00:00:02 systemd: run-timeshift-25719-backup.mount: Deactivated successfully.
Oct 09 00:00:02 CRON: pam_unix(cron:session): session closed for user root
Oct 09 00:12:11 kernel: perf: interrupt took too long (3931 > 3925), lowering kernel.perf_event_max_sample_rate to 50000
Oct 09 00:17:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 00:17:01 CRON: (root) CMD (cd / && run-parts --report /etc/cron.hourly)
Oct 09 00:17:01 CRON: pam_unix(cron:session): session closed for user root
Oct 09 00:24:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 00:24:01 CRON: (root) CMD (if [ $(date +%w) -eq 0 ] && [ -x /usr/lib/zfs-linux/scrub ]; then /usr/lib/zfs-linux/scrub; fi)
Oct 09 00:24:01 CRON: pam_unix(cron:session): session closed for user root
Oct 09 00:26:01 systemd: Starting fwupd-refresh.service - Refresh fwupd metadata and update motd...
Oct 09 00:26:01 systemd: fwupd-refresh.service: Deactivated successfully.
Oct 09 00:26:01 systemd: Finished fwupd-refresh.service - Refresh fwupd metadata and update motd.
Oct 09 01:00:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 01:00:01 CRON: (root) CMD (timeshift --check --scripted)
Oct 09 01:00:01 crontab: (root) LIST (root)
Oct 09 01:00:01 crontab: (root) LIST (root)
Oct 09 01:00:01 systemd: run-timeshift-26038-backup.mount: Deactivated successfully.
Oct 09 01:00:01 CRON: pam_unix(cron:session): session closed for user root
Oct 09 01:17:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 01:17:01 CRON: (root) CMD (cd / && run-parts --report /etc/cron.hourly)
Oct 09 01:17:01 CRON: pam_unix(cron:session): session closed for user root
Oct 09 01:26:01 systemd: Starting fwupd-refresh.service - Refresh fwupd metadata and update motd...
Oct 09 01:26:01 systemd: fwupd-refresh.service: Deactivated successfully.
Oct 09 01:26:01 systemd: Finished fwupd-refresh.service - Refresh fwupd metadata and update motd.
Oct 09 01:43:41 systemd: Starting motd-news.service - Message of the Day...
Oct 09 01:43:41 systemd: motd-news.service: Deactivated successfully.
Oct 09 01:43:41 systemd: Finished motd-news.service - Message of the Day.
Oct 09 02:00:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 02:00:01 CRON: (root) CMD (timeshift --check --scripted)
Oct 09 02:00:01 crontab: (root) LIST (root)
Oct 09 02:00:01 crontab: (root) LIST (root)
Oct 09 02:00:01 systemd: run-timeshift-26363-backup.mount: Deactivated successfully.
Oct 09 02:00:01 CRON: pam_unix(cron:session): session closed for user root
Oct 09 02:17:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 02:17:01 CRON: (root) CMD (cd / && run-parts --report /etc/cron.hourly)
Oct 09 02:17:01 CRON: pam_unix(cron:session): session closed for user root
Oct 09 02:41:01 systemd: Starting fwupd-refresh.service - Refresh fwupd metadata and update motd...
Oct 09 02:41:01 systemd: fwupd-refresh.service: Deactivated successfully.
Oct 09 02:41:01 systemd: Finished fwupd-refresh.service - Refresh fwupd metadata and update motd.
Oct 09 03:00:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 03:00:01 CRON: (root) CMD (timeshift --check --scripted)
Oct 09 03:00:02 crontab: (root) LIST (root)
Oct 09 03:00:02 crontab: (root) LIST (root)
Oct 09 03:00:02 systemd: run-timeshift-26683-backup.mount: Deactivated successfully.
Oct 09 03:00:02 CRON: pam_unix(cron:session): session closed for user root
Oct 09 03:10:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 03:10:01 CRON: (root) CMD (test -e /run/systemd/system || SERVICE_MODE=1 /sbin/e2scrub_all -A -r)
Oct 09 03:10:01 CRON: pam_unix(cron:session): session closed for user root
Oct 09 03:17:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 03:17:01 CRON: (root) CMD (cd / && run-parts --report /etc/cron.hourly)
Oct 09 03:17:01 CRON: pam_unix(cron:session): session closed for user root
Oct 09 03:54:10 systemd: Starting fwupd-refresh.service - Refresh fwupd metadata and update motd...
Oct 09 03:54:10 systemd: fwupd-refresh.service: Deactivated successfully.
Oct 09 03:54:10 systemd: Finished fwupd-refresh.service - Refresh fwupd metadata and update motd.
Oct 09 04:00:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 04:00:01 CRON: (root) CMD (timeshift --check --scripted)
Oct 09 04:00:01 crontab: (root) LIST (root)
Oct 09 04:00:01 crontab: (root) LIST (root)
Oct 09 04:00:01 systemd: run-timeshift-27007-backup.mount: Deactivated successfully.
Oct 09 04:00:01 CRON: pam_unix(cron:session): session closed for user root
Oct 09 04:17:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 04:17:01 CRON: (root) CMD (cd / && run-parts --report /etc/cron.hourly)
Oct 09 04:17:01 CRON: pam_unix(cron:session): session closed for user root
Oct 09 04:23:01 systemd: Starting fwupd-refresh.service - Refresh fwupd metadata and update motd...
Oct 09 04:23:01 systemd: fwupd-refresh.service: Deactivated successfully.
Oct 09 04:23:01 systemd: Finished fwupd-refresh.service - Refresh fwupd metadata and update motd.
Oct 09 05:00:01 CRON: pam_unix(cron:session): session opened for user root(uid=0) by root(uid=0)
Oct 09 05:00:01 CRON: (root) CMD (timeshift --check --scripted)
Oct 09 05:00:01 crontab: (root) LIST (root)
Oct 09 05:00:01 crontab: (root) LIST (root)
Oct 09 05:00:01 systemd: run-timeshift-27305-backup.mount: Deactivated successfully.
Oct 09 05:00:01 CRON: pam_unix(cron:session): session closed for user root
Oct 09 05:08:31 systemd: Starting plocate-updatedb.service - Update the plocate database...
Oct 09 05:10:46 systemd: plocate-updatedb.service: Deactivated successfully.
Oct 09 05:10:46 systemd: Finished plocate-updatedb.service - Update the plocate database.
Oct 09 05:10:46 systemd: plocate-updatedb.service: Consumed 1min 24.335s CPU time.
Oct 09 05:12:59 kernel: ACPI Error: AE_TIME, Returned by Handler for [EmbeddedControl] (20230628/evregion-296)
Oct 09 05:12:59 kernel: ACPI Error: Timeout from EC hardware or EC device driver (20230628/evregion-306)
Oct 09 05:12:59 kernel: 
Oct 09 05:12:59 kernel: 
                        Initialized Local Variables for Method [ECR1]:
Oct 09 05:12:59 kernel:   Local0: 000000007eb1c076            Integer 0000000000000000
Oct 09 05:12:59 kernel: 
Oct 09 05:12:59 kernel: Initialized Arguments for Method [ECR1]:  (1 arguments defined for method invocation)
Oct 09 05:12:59 kernel:   Arg0:   00000000465187ee            Integer 0000000000000034
Oct 09 05:12:59 kernel: 
Oct 09 05:12:59 kernel: ACPI Error: Aborting method \_SB.PCI0.LPCB.ECDV.ECR1 due to previous error (AE_TIME) (20230628/psparse-529)
Oct 09 05:12:59 kernel: ACPI Error: Aborting method \_SB.PCI0.LPCB.ECDV.KDRT due to previous error (AE_TIME) (20230628/psparse-529)
Oct 09 05:12:59 kernel: ACPI Error: Aborting method \_SB.PCI0.LPCB.ECDV.SEN3._TMP due to previous error (AE_TIME) (20230628/psparse-529)
Oct 09 05:12:59 thermald: critical temp reached
Oct 09 05:13:01 kernel: ACPI Error: AE_TIME, Returned by Handler for [EmbeddedControl] (20230628/evregion-296)
Oct 09 05:13:01 kernel: ACPI Error: Timeout from EC hardware or EC device driver (20230628/evregion-306)
Oct 09 05:13:01 kernel: 
Oct 09 05:13:01 kernel: No Local Variables are initialized for Method [ECW1]
Oct 09 05:13:01 kernel: 
Oct 09 05:13:01 kernel: Initialized Arguments for Method [ECW1]:  (2 arguments defined for method invocation)
Oct 09 05:13:01 kernel:   Arg0:   0000000010177d08            Integer 0000000000000033
Oct 09 05:13:01 kernel:   Arg1:   000000004a48fdbe            Integer 0000000000000003
Oct 09 05:13:01 kernel: 
Oct 09 05:13:01 kernel: ACPI Error: Aborting method \_SB.PCI0.LPCB.ECDV.ECW1 due to previous error (AE_TIME) (20230628/psparse-529)
Oct 09 05:13:01 kernel: ACPI Error: Aborting method \_SB.PCI0.LPCB.ECDV.KDRT due to previous error (AE_TIME) (20230628/psparse-529)
Oct 09 05:13:01 kernel: ACPI Error: Aborting method \_SB.PCI0.LPCB.ECDV.SEN2._TMP due to previous error (AE_TIME) (20230628/psparse-529)
Oct 09 05:13:04 kernel: ACPI Error: AE_TIME, Returned by Handler for [EmbeddedControl] (20230628/evregion-296)
Oct 09 05:13:04 kernel: ACPI Error: Timeout from EC hardware or EC device driver (20230628/evregion-306)
Oct 09 05:13:04 kernel: 
Oct 09 05:13:04 kernel: No Local Variables are initialized for Method [ECW1]
Oct 09 05:13:04 kernel: 
Oct 09 05:13:04 kernel: Initialized Arguments for Method [ECW1]:  (2 arguments defined for method invocation)
Oct 09 05:13:04 kernel:   Arg0:   0000000053ba8808            Integer 0000000000000033
Oct 09 05:13:04 kernel:   Arg1:   00000000a9c7eac9            Integer 0000000000000002
Oct 09 05:13:04 kernel: 
Oct 09 05:13:04 kernel: ACPI Error: Aborting method \_SB.PCI0.LPCB.ECDV.ECW1 due to previous error (AE_TIME) (20230628/psparse-529)
Oct 09 05:13:04 kernel: ACPI Error: Aborting method \_SB.PCI0.LPCB.ECDV.KDRT due to previous error (AE_TIME) (20230628/psparse-529)
Oct 09 05:13:04 kernel: ACPI Error: Aborting method \_SB.PCI0.TMEM._TMP due to previous error (AE_TIME) (20230628/psparse-529)
Oct 09 05:13:06 thermald: critical temp reached
Oct 09 05:13:06 kernel: ACPI Error: AE_TIME, Returned by Handler for [EmbeddedControl] (20230628/evregion-296)
Oct 09 05:13:06 kernel: ACPI Error: Timeout from EC hardware or EC device driver (20230628/evregion-306)
Oct 09 05:13:06 kernel: 
Oct 09 05:13:06 kernel: No Local Variables are initialized for Method [ECW1]
Oct 09 05:13:06 kernel: 
Oct 09 05:13:06 kernel: Initialized Arguments for Method [ECW1]:  (2 arguments defined for method invocation)
Oct 09 05:13:06 kernel:   Arg0:   00000000ecd5f192            Integer 0000000000000033
Oct 09 05:13:06 kernel:   Arg1:   00000000edf1d9c2            Integer 0000000000000000
Oct 09 05:13:06 kernel: 
Oct 09 05:13:06 kernel: ACPI Error: Aborting method \_SB.PCI0.LPCB.ECDV.ECW1 due to previous error (AE_TIME) (20230628/psparse-529)
Oct 09 05:13:06 kernel: ACPI Error: Aborting method \_SB.PCI0.LPCB.ECDV.KDRT due to previous error (AE_TIME) (20230628/psparse-529)
Oct 09 05:13:06 kernel: ACPI Error: Aborting method \_SB.PCI0.B0D4._TMP due to previous error (AE_TIME) (20230628/psparse-529)
Asked by Vlastimil Burián (30515 rep)
Oct 9, 2024, 07:41 AM
Last activity: Oct 9, 2024, 11:16 AM