Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

High CPU load (>90%) #28

Closed
hugodejong opened this issue Jan 17, 2022 · 10 comments
Closed

High CPU load (>90%) #28

hugodejong opened this issue Jan 17, 2022 · 10 comments

Comments

@hugodejong
Copy link

hugodejong commented Jan 17, 2022

Since a recent restart of the add-on, I've been seeing a CPU load that's way too high to be normal:

image

Data is coming into HA through MQTT and the web interface is available, so everything seems to work. The add-on log shows a lot of this:

`127.0.0.1 - - [17/Jan/2022:22:22:14 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:22:19 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:22:24 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:22:30 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:22:35 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:22:40 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:22:46 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:22:51 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:22:56 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:23:01 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:23:07 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:23:12 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:23:17 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:23:22 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:23:28 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"

127.0.0.1 - - [17/Jan/2022:22:23:33 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"`

Currently running v0.7.3.

I've tried:

  • Reverting the add-on to a previous version (0.7.2 I think), same problem
  • Rebooting the VM in which HA and the add-on run
  • Rebooting the host machine
@Sholofly
Copy link

Yeah, definately too high:
image

@ecoenjaerts
Copy link

Also see a sudden rise in CPU usage. Add on log contains multiple Errors. I am not an expert at all, but maybe this helps.

127.0.0.1 - - [18/Jan/2022:08:10:59 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:11:04 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:11:09 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:11:14 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:11:20 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:11:25 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
2022-01-18 08:11:27,547 ERROR schedule execute_scheduled_processes 37 | (PermissionError) dsmr_backup.services.backup.run errored: [Errno 13] Permission denied: '/backup/dsmrreader/dsmrreader-postgresql-backup-Tuesday.sql'
127.0.0.1 - - [18/Jan/2022:08:11:30 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:11:36 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:11:42 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:11:47 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:11:52 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:11:57 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
2022-01-18 08:11:58,101 ERROR schedule execute_scheduled_processes 37 | (PermissionError) dsmr_backup.services.backup.run errored: [Errno 13] Permission denied: '/backup/dsmrreader/dsmrreader-postgresql-backup-Tuesday.sql'
127.0.0.1 - - [18/Jan/2022:08:12:03 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:12:08 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:12:13 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:12:18 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:08:12:24 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
2022-01-18 08:12:28,979 ERROR schedule execute_scheduled_processes 37 | (PermissionError) dsmr_backup.services.backup.run errored: [Errno 13] Permission denied: '/backup/dsmrreader/dsmrreader-postgresql-backup-Tuesday.sql'

@hugodejong
Copy link
Author

hugodejong commented Jan 18, 2022

Also seeing these PermissionErrors now.

127.0.0.1 - - [18/Jan/2022:09:55:07 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:09:55:13 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:09:55:18 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:09:55:23 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:09:55:28 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:09:55:34 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
2022-01-18 09:55:34,757 ERROR schedule execute_scheduled_processes 37 | (PermissionError) dsmr_backup.services.backup.run errored: [Errno 13] Permission denied: '/backup/dsmrreader/dsmrreader-postgresql-backup-Tuesday.sql'
[2022-01-18 09:55:39 +0100] [637990] [INFO] Autorestarting worker after current request.
127.0.0.1 - - [18/Jan/2022:09:55:39 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
[2022-01-18 09:55:39 +0100] [637990] [INFO] Worker exiting (pid: 637990)
[2022-01-18 09:55:40 +0100] [680261] [INFO] Booting worker with pid: 680261
127.0.0.1 - - [18/Jan/2022:09:55:46 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:09:55:51 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:09:55:57 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
127.0.0.1 - - [18/Jan/2022:09:56:02 +0100] "GET /about HTTP/1.1" 200 14772 "-" "curl/7.79.1" "-"
2022-01-18 09:56:05,764 ERROR schedule execute_scheduled_processes 37 | (PermissionError) dsmr_backup.services.backup.run errored: [Errno 13] Permission denied: '/backup/dsmrreader/dsmrreader-postgresql-backup-Tuesday.sql'

@sanderdw
Copy link
Owner

Not tested well enough, i see... To fix these errors on the new set-up i need some extra time so in the mean time i published DSMR-reader 0.7.3 which is just the previous working config. Let me know if that fixes it for now.

@Sholofly
Copy link

0.7.3 was already the latest version, wasn't it? I don't see updates now...

@sanderdw
Copy link
Owner

I need to wake up, yes indeed DSMR-reader 0.7.4 👍

@Sholofly
Copy link

That looks good!

image

@Alfagek
Copy link

Alfagek commented Jan 18, 2022

Thanks for the quick “fix” @sanderdw the new-old version 0.7.4 works again with almost no cpu power again

@hugodejong
Copy link
Author

My HA has not detected the update yet, will let you know whether it has fixed it. Is there a trick to have HA check for add-on updates? :)

@hugodejong
Copy link
Author

Works like a dream again. Thank you @sanderdw for the speedy solve!

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

5 participants