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.

Sign up for GitHub

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

Jump to bottom

Error deleting non-existing backups #997

Open
DanielRitter75 opened this issue Feb 22, 2024 · 1 comment
Open

Error deleting non-existing backups #997

DanielRitter75 opened this issue Feb 22, 2024 · 1 comment

Comments

@DanielRitter75
Copy link

Description:
If I try to delete a backup via UI that's not existing anymore in the backup folder of HA I get the following error:

  addon/backup/ha/harequests.py:105 (delete)
  addon/backup/ha/harequests.py:34 (wrap_and_call)
  addon/backup/ha/harequests.py:280 (_sendHassioData)
  addon/backup/ha/harequests.py:225 (_validateHassioReply)
  /site-packages/aiohttp/client_reqrep.py:1059 (raise_for_status)
aiohttp.client_exceptions.ClientResponseError: 400, message='Bad Request', url=URL('http://supervisor/backups/bab0d5c8')
Whose handling caused:
  addon/backup/ui/uiserver.py:801 (error_middleware)
  addon/backup/ui/uiserver.py:305 (deleteSnapshot)
  addon/backup/model/coordinator.py:295 (delete)
  addon/backup/model/coordinator.py:353 (_withSoftLock)
  addon/backup/model/coordinator.py:304 (_delete)
  addon/backup/ha/hasource.py:355 (delete)
  addon/backup/ha/harequests.py:34 (wrap_and_call)
  addon/backup/ha/harequests.py:111 (delete)
backup.exceptions.exceptions.HomeAssistantDeleteError


Solution at the moment:
- Trying to delete the backup 
- Checking the error-message to get the filename (part of the URL) of the non existing backup-file
- Creating a new .tar-file in the HA-backup-folder with this filename
- Deleting backup via UI

Addon version: 0.112.1
Home Assistant Version: 2024.2.2
Supervisor Version: 2024.02.0
Supervisor Channel: stable
Hassos Version: 11.5
Docker Version: 24.0.7
Architecture: aarch64
Machine: raspberrypi4-64
Date: 2024-02-22T23:06:10.984709+00:00
Timezone: Europe/Berlin
Failure Time: 2024-02-22T22:55:53.619706+00:00
Last Good Sync: 2024-02-22T23:05:03.482826+00:00
Next Sync: 2024-02-23T00:52:22.155831+00:00
Next Backup: 2024-02-23T02:00:00+00:00
Next Cache Warm: 2024-02-23T00:44:12.700344+00:00
Time Offset: 0.0

Exception:
No error could be identified automatically.

Backups:

{
   "HomeAssistant": {
       "backups": 1,
       "retained": 0,
       "deletable": 1,
       "name": "HomeAssistant",
       "title": "Home Assistant",
       "latest": "2024-02-22T22:47:18Z",
       "max": 3,
       "enabled": true,
       "icon": "home-assistant",
       "ignored": 29,
       "detail": "",
       "size": "1.4 GB",
       "ignored_size": "103.7 MB",
       "free_space": "193.6 GB"
   },
   "GoogleDrive": {
       "backups": 1,
       "retained": 0,
       "deletable": 1,
       "name": "GoogleDrive",
       "title": "Google Drive",
       "latest": "2024-02-22T22:47:18Z",
       "max": 3,
       "enabled": true,
       "icon": "google-drive",
       "ignored": 0,
       "detail": "connect.danny@googlemail.com",
       "size": "1.4 GB",
       "ignored_size": "0.0 B",
       "free_space": "53.3 GB"
   }
}
Config:
{
   "Setting.MAX_BACKUPS_IN_HA": 3,
   "Setting.MAX_BACKUPS_IN_GOOGLE_DRIVE": 3,
   "Setting.DAYS_BETWEEN_BACKUPS": 1.0,
   "Setting.BACKUP_TIME_OF_DAY": "03:00",
   "Setting.SEND_ERROR_REPORTS": true
}
Addon Logs:
02-23 00:00:26 INFO [backup.ha.hasource] Deleting 'Full Backup 2024-02-22 05:46:39' from Home Assistant
02-23 00:00:26 ERROR [backup.ui.uiserver] Error serving POST http://homeassistant.local:8123/deleteSnapshot
02-23 00:00:26 ERROR [backup.ui.uiserver] 
 addon/backup/ha/harequests.py:105 (delete)
 addon/backup/ha/harequests.py:34 (wrap_and_call)
 addon/backup/ha/harequests.py:280 (_sendHassioData)
 addon/backup/ha/harequests.py:225 (_validateHassioReply)
 /site-packages/aiohttp/client_reqrep.py:1059 (raise_for_status)
aiohttp.client_exceptions.ClientResponseError: 400, message='Bad Request', url=URL('http://supervisor/backups/a5e553ac')
Whose handling caused:
 addon/backup/ui/uiserver.py:801 (error_middleware)
 addon/backup/ui/uiserver.py:305 (deleteSnapshot)
 addon/backup/model/coordinator.py:295 (delete)
 addon/backup/model/coordinator.py:353 (_withSoftLock)
 addon/backup/model/coordinator.py:304 (_delete)
 addon/backup/ha/hasource.py:355 (delete)
 addon/backup/ha/harequests.py:34 (wrap_and_call)
 addon/backup/ha/harequests.py:111 (delete)
backup.exceptions.exceptions.HomeAssistantDeleteError

02-23 00:00:44 INFO [backup.watcher] A backup directory file was modified, we'll check for new backups soon.
02-23 00:01:20 INFO [backup.ha.hasource] Deleting 'Full Backup 2024-02-22 05:46:39' from Home Assistant
02-23 00:01:20 INFO [backup.watcher] The backup directory is still being written to, waiting...
02-23 00:01:30 DEBUG [backup.watcher] Checking backup source for changes...
02-23 00:01:30 DEBUG [backup.model.syncer] Sync requested by Backup Directory Watcher
02-23 00:01:30 INFO [backup.model.coordinator] Syncing Backups
02-23 00:01:37 INFO [backup.debugworker] Sending error report (see settings to disable)
02-23 00:02:16 ERROR [backup.ui.uiserver] Error serving GET http://homeassistant.local:8123/download?slug=a18c2a04
02-23 00:02:16 ERROR [backup.ui.uiserver] 
 addon/backup/ui/uiserver.py:801 (error_middleware)
 addon/backup/ui/uiserver.py:646 (download)
 addon/backup/util/asynchttpgetter.py:61 (setup)
 addon/backup/util/asynchttpgetter.py:167 (_startReadRemoteAt)
 addon/backup/tracing_session.py:39 (_request)
 /site-packages/aiohttp/client.py:601 (_request)
 /site-packages/aiohttp/client_reqrep.py:965 (start)
 /site-packages/aiohttp/streams.py:622 (read)
aiohttp.client_exceptions.ServerDisconnectedError: Server disconnected

02-23 00:02:46 INFO [backup.ha.hasource] Deleting 'addon_a0d7b954_nodered_17.0.1' from Home Assistant
02-23 00:02:46 ERROR [backup.ui.uiserver] Error serving POST http://homeassistant.local:8123/deleteSnapshot
02-23 00:02:46 ERROR [backup.ui.uiserver] 
 addon/backup/ha/harequests.py:105 (delete)
 addon/backup/ha/harequests.py:34 (wrap_and_call)
 addon/backup/ha/harequests.py:280 (_sendHassioData)
 addon/backup/ha/harequests.py:225 (_validateHassioReply)
 /site-packages/aiohttp/client_reqrep.py:1059 (raise_for_status)
aiohttp.client_exceptions.ClientResponseError: 400, message='Bad Request', url=URL('http://supervisor/backups/a18c2a04')
Whose handling caused:
 addon/backup/ui/uiserver.py:801 (error_middleware)
 addon/backup/ui/uiserver.py:305 (deleteSnapshot)
 addon/backup/model/coordinator.py:295 (delete)
 addon/backup/model/coordinator.py:353 (_withSoftLock)
 addon/backup/model/coordinator.py:304 (_delete)
 addon/backup/ha/hasource.py:355 (delete)
 addon/backup/ha/harequests.py:34 (wrap_and_call)
 addon/backup/ha/harequests.py:111 (delete)
backup.exceptions.exceptions.HomeAssistantDeleteError

02-23 00:03:09 INFO [backup.watcher] A backup directory file was modified, we'll check for new backups soon.
02-23 00:03:21 DEBUG [backup.watcher] Checking backup source for changes...
02-23 00:04:03 INFO [backup.ha.hasource] Deleting 'addon_5c53de3b_esphome_2023.12.5' from Home Assistant
02-23 00:04:03 ERROR [backup.ui.uiserver] Error serving POST http://homeassistant.local:8123/deleteSnapshot
02-23 00:04:03 ERROR [backup.ui.uiserver] 
 addon/backup/ha/harequests.py:105 (delete)
 addon/backup/ha/harequests.py:34 (wrap_and_call)
 addon/backup/ha/harequests.py:280 (_sendHassioData)
 addon/backup/ha/harequests.py:225 (_validateHassioReply)
 /site-packages/aiohttp/client_reqrep.py:1059 (raise_for_status)
aiohttp.client_exceptions.ClientResponseError: 400, message='Bad Request', url=URL('http://supervisor/backups/936df7f4')
Whose handling caused:
 addon/backup/ui/uiserver.py:801 (error_middleware)
 addon/backup/ui/uiserver.py:305 (deleteSnapshot)
 addon/backup/model/coordinator.py:295 (delete)
 addon/backup/model/coordinator.py:353 (_withSoftLock)
 addon/backup/model/coordinator.py:304 (_delete)
 addon/backup/ha/hasource.py:355 (delete)
 addon/backup/ha/harequests.py:34 (wrap_and_call)
 addon/backup/ha/harequests.py:111 (delete)
backup.exceptions.exceptions.HomeAssistantDeleteError

02-23 00:04:16 INFO [backup.watcher] A backup directory file was modified, we'll check for new backups soon.
02-23 00:04:49 INFO [backup.ha.hasource] Deleting 'addon_a0d7b954_nodered_17.0.1' from Home Assistant
02-23 00:04:49 INFO [backup.watcher] The backup directory is still being written to, waiting...
02-23 00:04:53 INFO [backup.ha.hasource] Deleting 'addon_5c53de3b_esphome_2023.12.5' from Home Assistant
02-23 00:05:03 DEBUG [backup.watcher] Checking backup source for changes...
02-23 00:05:03 DEBUG [backup.model.syncer] Sync requested by Backup Directory Watcher
02-23 00:05:03 INFO [backup.model.coordinator] Syncing Backups
02-23 00:05:53 INFO [backup.ha.hasource] Deleting 'addon_a0d7b954_ssh_17.0.3' from Home Assistant
02-23 00:05:53 ERROR [backup.ui.uiserver] Error serving POST http://homeassistant.local:8123/deleteSnapshot
02-23 00:05:53 ERROR [backup.ui.uiserver] 
 addon/backup/ha/harequests.py:105 (delete)
 addon/backup/ha/harequests.py:34 (wrap_and_call)
 addon/backup/ha/harequests.py:280 (_sendHassioData)
 addon/backup/ha/harequests.py:225 (_validateHassioReply)
 /site-packages/aiohttp/client_reqrep.py:1059 (raise_for_status)
aiohttp.client_exceptions.ClientResponseError: 400, message='Bad Request', url=URL('http://supervisor/backups/bab0d5c8')
Whose handling caused:
 addon/backup/ui/uiserver.py:801 (error_middleware)
 addon/backup/ui/uiserver.py:305 (deleteSnapshot)
 addon/backup/model/coordinator.py:295 (delete)
 addon/backup/model/coordinator.py:353 (_withSoftLock)
 addon/backup/model/coordinator.py:304 (_delete)
 addon/backup/ha/hasource.py:355 (delete)
 addon/backup/ha/harequests.py:34 (wrap_and_call)
 addon/backup/ha/harequests.py:111 (delete)
backup.exceptions.exceptions.HomeAssistantDeleteError
Supervisor Logs:
�[32m24-02-23 00:03:25 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:04:03 INFO (MainThread) [supervisor.api.middleware.security] /backups/936df7f4 access from cebe7a76_hassio_google_drive_backup�[0m
�[31m24-02-23 00:04:03 ERROR (MainThread) [supervisor.backups.manager] Can't remove backup 936df7f4: [Errno 2] No such file or directory: '/data/backup/936df7f4.tar'�[0m
�[32m24-02-23 00:04:06 INFO (MainThread) [supervisor.api.middleware.security] /os/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:04:06 INFO (MainThread) [supervisor.api.middleware.security] /core/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:04:06 INFO (MainThread) [supervisor.api.middleware.security] /host/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:04:11 INFO (MainThread) [supervisor.api.middleware.security] /host/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:04:11 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:04:49 INFO (MainThread) [supervisor.api.middleware.security] /backups/a18c2a04 access from cebe7a76_hassio_google_drive_backup�[0m
�[32m24-02-23 00:04:49 INFO (MainThread) [supervisor.backups.manager] Removed backup file a18c2a04�[0m
�[32m24-02-23 00:04:52 INFO (MainThread) [supervisor.api.middleware.security] /os/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:04:52 INFO (MainThread) [supervisor.api.middleware.security] /core/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:04:52 INFO (MainThread) [supervisor.api.middleware.security] /host/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:04:53 INFO (MainThread) [supervisor.api.middleware.security] /backups/936df7f4 access from cebe7a76_hassio_google_drive_backup�[0m
�[32m24-02-23 00:04:53 INFO (MainThread) [supervisor.backups.manager] Removed backup file 936df7f4�[0m
�[32m24-02-23 00:04:57 INFO (MainThread) [supervisor.api.middleware.security] /host/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:04:57 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:05:03 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/info access from cebe7a76_hassio_google_drive_backup�[0m
�[32m24-02-23 00:05:03 INFO (MainThread) [supervisor.api.middleware.security] /backups access from cebe7a76_hassio_google_drive_backup�[0m
�[32m24-02-23 00:05:03 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/info access from cebe7a76_hassio_google_drive_backup�[0m
�[32m24-02-23 00:05:03 INFO (MainThread) [supervisor.api.middleware.security] /backups access from cebe7a76_hassio_google_drive_backup�[0m
�[32m24-02-23 00:05:37 INFO (MainThread) [supervisor.api.middleware.security] /os/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:05:37 INFO (MainThread) [supervisor.api.middleware.security] /core/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:05:37 INFO (MainThread) [supervisor.api.middleware.security] /host/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:05:43 INFO (MainThread) [supervisor.api.middleware.security] /host/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:05:43 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from aef95bf7_i2c_oled_display�[0m
�[32m24-02-23 00:05:53 INFO (MainThread) [supervisor.api.middleware.security] /backups/bab0d5c8 access from cebe7a76_hassio_google_drive_backup�[0m
�[31m24-02-23 00:05:53 ERROR (MainThread) [supervisor.backups.manager] Can't remove backup bab0d5c8: [Errno 2] No such file or directory: '/data/backup/bab0d5c8.tar'�[0m
�[32m24-02-23 00:06:11 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/logs access from cebe7a76_hassio_google_drive_backup�[0m
Home Assistant Core Logs:
�[32m2024-02-23 00:05:58.395 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.408 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.417 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.426 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.438 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.449 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.458 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.468 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.479 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.491 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.501 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.510 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.522 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.531 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.541 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.550 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.561 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.570 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.580 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.590 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.602 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.614 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.627 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.638 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.648 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.659 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[32m2024-02-23 00:05:58.670 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [546754052672] Initialized trigger�[0m
�[31m2024-02-23 00:06:04.487 ERROR (MainThread) [custom_components.xmrig.restapicall] Error fetching data: http://192.168.3.220:18008/2/summary failed with �[0m
�[32m2024-02-23 00:06:04.488 INFO (MainThread) [custom_components.xmrig.hwm_controller] async_Update(MEMORY-summary) - no data received�[0m
@sabeechen
Copy link
Owner

Sorry this took me a while to get back to you, I had to step away from addon support for a while. The supervisor log:

[31m24-02-23 00:05:53 ERROR (MainThread) [supervisor.backups.manager] Can't remove backup bab0d5c8: [Errno 2] No such file or directory: '/data/backup/bab0d5c8.tar'

I think indicates HA's cache of its backups is messed up, its trying to delete a file that doesn't exist. You should be able to refresh it with a reboot. Does this persist if you restart the Home Assistant host machine.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@sabeechen @DanielRitter75