sabeechen / hassio-google-drive-backup

Automatically create and sync Home Assistant backups into Google Drive
MIT License
3.16k stars 193 forks source link

Snapshots stop working at some point #681

Closed JJussi closed 2 years ago

JJussi commented 2 years ago
Description:
If you have anything else that could help explain what happened, click "Markdown" above and write it here.

Addon version: 0.104.3 Home Assistant Version: 2022.7.7 Supervisor Version: 2022.07.0 Supervisor Channel: stable Hassos Version: 8.4 Docker Version: 20.10.14 Architecture: aarch64 Machine: raspberrypi4-64 Date: 2022-07-30T13:24:00.555882+00:00 Timezone: Europe/Helsinki Failure Time: 2022-07-30T13:23:40.014133+00:00 Last Good Sync: 2022-07-30T13:23:39.995997+00:00

Exception:

  addon/backup/model/coordinator.py:176 (_sync)
  addon/backup/model/model.py:167 (sync)
  addon/backup/model/model.py:261 (_syncSnapshots)
  addon/backup/ha/hasource.py:246 (get)
  addon/backup/ha/harequests.py:28 (wrap_and_call)
  addon/backup/ha/harequests.py:108 (snapshots)
  addon/backup/ha/harequests.py:28 (wrap_and_call)
  addon/backup/ha/harequests.py:221 (_getHassioData)
  addon/backup/ha/harequests.py:181 (_validateHassioReply)
  /site-packages/aiohttp/client_reqrep.py:1000 (raise_for_status)
aiohttp.client_exceptions.ClientResponseError: 404, message='Not Found', url=URL('http://hassio/snapshots')

Snapshots:

 {
    "HomeAssistant": {
        "snapshots": 0,
        "retained": 0,
        "deletable": 0,
        "name": "HomeAssistant",
        "title": "Home Assistant",
        "latest": null,
        "max": 10,
        "enabled": true,
        "icon": "home-assistant",
        "ignored": 0,
        "size": "0.0 B",
        "ignored_size": "0.0 B",
        "free_space": "208.5 GB"
    },
    "GoogleDrive": {
        "snapshots": 0,
        "retained": 0,
        "deletable": 0,
        "name": "GoogleDrive",
        "title": "Google Drive",
        "latest": null,
        "max": 10,
        "enabled": true,
        "icon": "google-drive",
        "ignored": 0,
        "size": "0.0 B",
        "ignored_size": "0.0 B"
    }
}
Config:
 {
    "Setting.MAX_SNAPSHOTS_IN_HASSIO": 10,
    "Setting.MAX_SNAPSHOTS_IN_GOOGLE_DRIVE": 10,
    "Setting.DAYS_BETWEEN_SNAPSHOTS": 1.0,
    "Setting.SNAPSHOT_TIME_OF_DAY": "00:01",
    "Setting.SPECIFY_SNAPSHOT_FOLDER": true,
    "Setting.SEND_ERROR_REPORTS": true,
    "Setting.DRIVE_IPV4": "108.177.14.95",
    "Setting.ALTERNATE_DNS_SERVERS": "1.1.1.1"
}
Addon Logs:
 07-30 16:21:10 DEBUG [backup.model.syncer] Sync requested by HomeAssistant
07-30 16:21:10 INFO [backup.model.coordinator] Syncing Snapshots
07-30 16:21:10 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/snapshots
07-30 16:21:10 ERROR [backup.model.coordinator] 
  addon/backup/model/coordinator.py:176 (_sync)
  addon/backup/model/model.py:167 (sync)
  addon/backup/model/model.py:261 (_syncSnapshots)
  addon/backup/ha/hasource.py:246 (get)
  addon/backup/ha/harequests.py:28 (wrap_and_call)
  addon/backup/ha/harequests.py:108 (snapshots)
  addon/backup/ha/harequests.py:28 (wrap_and_call)
  addon/backup/ha/harequests.py:221 (_getHassioData)
  addon/backup/ha/harequests.py:181 (_validateHassioReply)
  /site-packages/aiohttp/client_reqrep.py:1000 (raise_for_status)
aiohttp.client_exceptions.ClientResponseError: 404, message='Not Found', url=URL('http://hassio/snapshots')

07-30 16:21:10 INFO [backup.model.coordinator] I'll try again in an hour
07-30 16:21:26 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/addons/self/info
07-30 16:21:26 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/info
07-30 16:21:26 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/core/info
07-30 16:21:26 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/supervisor/info
07-30 16:23:30 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/addons/self/options
07-30 16:23:30 INFO [backup.drive.folderfinder] Saving snapshot folder: 1NvVqufMQ-Z-xkwMMRNwWEtYPxvhPYfeR
07-30 16:23:30 INFO [backup.model.coordinator] Syncing Snapshots
07-30 16:23:30 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/snapshots
07-30 16:23:30 ERROR [backup.model.coordinator] 
  addon/backup/model/coordinator.py:176 (_sync)
  addon/backup/model/model.py:167 (sync)
  addon/backup/model/model.py:261 (_syncSnapshots)
  addon/backup/ha/hasource.py:246 (get)
  addon/backup/ha/harequests.py:28 (wrap_and_call)
  addon/backup/ha/harequests.py:108 (snapshots)
  addon/backup/ha/harequests.py:28 (wrap_and_call)
  addon/backup/ha/harequests.py:221 (_getHassioData)
  addon/backup/ha/harequests.py:181 (_validateHassioReply)
  /site-packages/aiohttp/client_reqrep.py:1000 (raise_for_status)
aiohttp.client_exceptions.ClientResponseError: 404, message='Not Found', url=URL('http://hassio/snapshots')

07-30 16:23:30 INFO [backup.model.coordinator] I'll try again in an hour
07-30 16:23:39 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/addons/self/info
07-30 16:23:39 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/info
07-30 16:23:39 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/core/info
07-30 16:23:39 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/supervisor/info
07-30 16:23:39 INFO [backup.ha.hasource] Requesting a new snapshot
07-30 16:23:39 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/snapshots/new/full
07-30 16:23:39 ERROR [backup.ha.hasource] Snapshot failed:
07-30 16:23:39 ERROR [backup.ha.hasource] 
  addon/backup/ha/hasource.py:434 (_requestAsync)
  /usr/lib/python3.8/asyncio/tasks.py:494 (wait_for)
  addon/backup/ha/harequests.py:28 (wrap_and_call)
  addon/backup/ha/harequests.py:60 (createSnapshot)
  addon/backup/ha/harequests.py:28 (wrap_and_call)
  addon/backup/ha/harequests.py:226 (_postHassioData)
  addon/backup/ha/harequests.py:181 (_validateHassioReply)
  /site-packages/aiohttp/client_reqrep.py:1000 (raise_for_status)
aiohttp.client_exceptions.ClientResponseError: 404, message='Not Found', url=URL('http://hassio/snapshots/new/full')

07-30 16:23:39 ERROR [backup.ui.uiserver] Error serving POST http://ha.jjussi.com/snapshot?custom_name=&retain_drive=false&retain_ha=false
07-30 16:23:39 ERROR [backup.ui.uiserver] 
  addon/backup/ui/uiserver.py:684 (error_middleware)
  addon/backup/ui/uiserver.py:262 (snapshot)
  addon/backup/model/coordinator.py:236 (startSnapshot)
  addon/backup/model/coordinator.py:319 (_withSoftLock)
  addon/backup/model/coordinator.py:241 (_startSnapshot)
  addon/backup/ha/hasource.py:214 (create)
  addon/backup/ha/hasource.py:96 (raiseIfNeeded)
  addon/backup/ha/hasource.py:434 (_requestAsync)
  /usr/lib/python3.8/asyncio/tasks.py:494 (wait_for)
  addon/backup/ha/harequests.py:28 (wrap_and_call)
  addon/backup/ha/harequests.py:60 (createSnapshot)
  addon/backup/ha/harequests.py:28 (wrap_and_call)
  addon/backup/ha/harequests.py:226 (_postHassioData)
  addon/backup/ha/harequests.py:181 (_validateHassioReply)
  /site-packages/aiohttp/client_reqrep.py:1000 (raise_for_status)
aiohttp.client_exceptions.ClientResponseError: 404, message='Not Found', url=URL('http://hassio/snapshots/new/full')

07-30 16:23:39 DEBUG [backup.model.syncer] Sync requested by HomeAssistant
07-30 16:23:39 INFO [backup.model.coordinator] Syncing Snapshots
07-30 16:23:39 DEBUG [backup.ha.harequests] Making Hassio request: http://hassio/snapshots
07-30 16:23:40 ERROR [backup.model.coordinator] 
  addon/backup/model/coordinator.py:176 (_sync)
  addon/backup/model/model.py:167 (sync)
  addon/backup/model/model.py:261 (_syncSnapshots)
  addon/backup/ha/hasource.py:246 (get)
  addon/backup/ha/harequests.py:28 (wrap_and_call)
  addon/backup/ha/harequests.py:108 (snapshots)
  addon/backup/ha/harequests.py:28 (wrap_and_call)
  addon/backup/ha/harequests.py:221 (_getHassioData)
  addon/backup/ha/harequests.py:181 (_validateHassioReply)
  /site-packages/aiohttp/client_reqrep.py:1000 (raise_for_status)
aiohttp.client_exceptions.ClientResponseError: 404, message='Not Found', url=URL('http://hassio/snapshots')

07-30 16:23:40 INFO [backup.model.coordinator] I'll try again in an hour
Supervisor Logs:
 22-07-30 15:56:22 INFO (MainThread) [supervisor.host.manager] Host information reload completed
22-07-30 16:00:43 WARNING (MainThread) [supervisor.addons.options] Option 'anonymous' does not exist in the schema for Mosquitto broker (core_mosquitto)
22-07-30 16:00:43 WARNING (MainThread) [supervisor.addons.options] Option 'dark_mode' does not exist in the schema for Node-RED (a0d7b954_nodered)
22-07-30 16:00:43 WARNING (MainThread) [supervisor.addons.options] Option 'require_ssl' does not exist in the schema for Node-RED (a0d7b954_nodered)
22-07-30 16:05:45 WARNING (MainThread) [supervisor.addons.options] Option 'anonymous' does not exist in the schema for Mosquitto broker (core_mosquitto)
22-07-30 16:05:45 WARNING (MainThread) [supervisor.addons.options] Option 'dark_mode' does not exist in the schema for Node-RED (a0d7b954_nodered)
22-07-30 16:05:45 WARNING (MainThread) [supervisor.addons.options] Option 'require_ssl' does not exist in the schema for Node-RED (a0d7b954_nodered)
22-07-30 16:10:47 WARNING (MainThread) [supervisor.addons.options] Option 'anonymous' does not exist in the schema for Mosquitto broker (core_mosquitto)
22-07-30 16:10:47 WARNING (MainThread) [supervisor.addons.options] Option 'dark_mode' does not exist in the schema for Node-RED (a0d7b954_nodered)
22-07-30 16:10:47 WARNING (MainThread) [supervisor.addons.options] Option 'require_ssl' does not exist in the schema for Node-RED (a0d7b954_nodered)
22-07-30 16:15:49 WARNING (MainThread) [supervisor.addons.options] Option 'anonymous' does not exist in the schema for Mosquitto broker (core_mosquitto)
22-07-30 16:15:49 WARNING (MainThread) [supervisor.addons.options] Option 'dark_mode' does not exist in the schema for Node-RED (a0d7b954_nodered)
22-07-30 16:15:49 WARNING (MainThread) [supervisor.addons.options] Option 'require_ssl' does not exist in the schema for Node-RED (a0d7b954_nodered)
22-07-30 16:20:51 WARNING (MainThread) [supervisor.addons.options] Option 'anonymous' does not exist in the schema for Mosquitto broker (core_mosquitto)
22-07-30 16:20:51 WARNING (MainThread) [supervisor.addons.options] Option 'dark_mode' does not exist in the schema for Node-RED (a0d7b954_nodered)
22-07-30 16:20:51 WARNING (MainThread) [supervisor.addons.options] Option 'require_ssl' does not exist in the schema for Node-RED (a0d7b954_nodered)
22-07-30 16:21:10 INFO (MainThread) [supervisor.api.middleware.security] /core/info access from cebe7a76_hassio_google_drive_backup
22-07-30 16:21:10 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/info access from cebe7a76_hassio_google_drive_backup
22-07-30 16:21:10 INFO (MainThread) [supervisor.api.middleware.security] /snapshots/new/full access from cebe7a76_hassio_google_drive_backup
22-07-30 16:21:10 INFO (MainThread) [supervisor.api.middleware.security] /snapshots access from cebe7a76_hassio_google_drive_backup
22-07-30 16:21:26 INFO (MainThread) [supervisor.api.middleware.security] /core/info access from cebe7a76_hassio_google_drive_backup
22-07-30 16:21:26 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/info access from cebe7a76_hassio_google_drive_backup
22-07-30 16:21:50 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
22-07-30 16:23:30 INFO (MainThread) [supervisor.api.middleware.security] /snapshots access from cebe7a76_hassio_google_drive_backup
22-07-30 16:23:39 INFO (MainThread) [supervisor.api.middleware.security] /core/info access from cebe7a76_hassio_google_drive_backup
22-07-30 16:23:39 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/info access from cebe7a76_hassio_google_drive_backup
22-07-30 16:23:39 INFO (MainThread) [supervisor.api.middleware.security] /snapshots/new/full access from cebe7a76_hassio_google_drive_backup
22-07-30 16:23:40 INFO (MainThread) [supervisor.api.middleware.security] /snapshots access from cebe7a76_hassio_google_drive_backup
22-07-30 16:24:00 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/logs access from cebe7a76_hassio_google_drive_backup
Home Assistant Core Logs:
 2022-07-30 14:56:27 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 15:02:07 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 15:02:27 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 15:02:57 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 15:08:37 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 15:08:57 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 15:09:27 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 15:15:07 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 15:20:37 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 15:26:07 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 15:26:27 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 15:26:57 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 15:32:37 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 15:32:57 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 15:33:27 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 15:39:07 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 15:44:37 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 15:50:07 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 15:55:37 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 16:01:07 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 16:01:27 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 16:07:07 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 16:07:27 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 16:07:57 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 16:13:07 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 16:13:27 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 16:19:07 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.wd1_bt_kitchen_temperature is taking over 10 seconds
2022-07-30 16:19:27 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
2022-07-30 16:19:57 WARNING (MainThread) [homeassistant.components.sensor] Updating mitemp_bt sensor took longer than the scheduled update interval 0:00:30
JJussi commented 2 years ago

And... Now HA finds all backups suddenly... And can make new backups.