Comment 8 for bug 2003925

Revision history for this message
Alvin Cura (alvinc) wrote :

Here on a different host without Open vSwitch. I'm guessing a race condition, because there is no reason for connection problem otherwise.

023-01-24 20:50:42,983 - handlers.py[DEBUG]: Queuing POST to http://10.100.127.223:5248/MAAS/metadata/status/6th3hw, data: {'name': 'init-local', 'description': 'searching for loc
al datasources', 'event_type': 'finish', 'origin': 'cloudinit', 'timestamp': 1674593442.9835653, 'result': 'SUCCESS'}
2023-01-24 20:50:42,983 - handlers.py[DEBUG]: WebHookHandler flushing remaining events
2023-01-24 20:50:42,985 - handlers.py[WARNING]: Failed posting event: {"name": "init-local", "description": "searching for local datasources", "event_type": "finish", "origin": "cl
oudinit", "timestamp": 1674593442.9835653, "result": "SUCCESS"}. This was caused by: HTTPConnectionPool(host='10.100.127.223', port=5248): Max retries exceeded with url: /MAAS/meta
data/status/6th3hw (Caused by NewConnectionError('<urllib3.connection.HTTPConnection object at 0x7fea47ffe160>: Failed to establish a new connection: [Errno 101] Network is unreach
able'))
2023-01-24 20:50:42,985 - handlers.py[WARNING]: Multiple consecutive failures in WebHookHandler. Cancelling all queued events.
2023-01-24 20:50:48,208 - util.py[DEBUG]: Cloud-init v. 22.4.2-0ubuntu0~20.04.2 running 'init' at Tue, 24 Jan 2023 20:50:48 +0000. Up 17.87 seconds.
2023-01-24 20:50:48,208 - main.py[DEBUG]: No kernel command line url found.
2023-01-24 20:50:48,208 - main.py[DEBUG]: Closing stdin.

Now, a few lines down the logfile, it does connect:
2023-01-24 20:50:48,218 - handlers.py[DEBUG]: start: init-network/check-cache: attempting to read from cache [trust]
2023-01-24 20:50:48,218 - handlers.py[DEBUG]: Queuing POST to http://10.100.127.223:5248/MAAS/metadata/status/6th3hw, data: {'name': 'init-network/check-cache', 'description': 'attempting to read from cache [trust]', 'event_type': 'start', 'origin': 'cloudinit', 'timestamp': 1674593448.2180347}
2023-01-24 20:50:48,218 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/obj.pkl (quiet=False)
2023-01-24 20:50:48,218 - stages.py[DEBUG]: no cache found
2023-01-24 20:50:48,218 - handlers.py[DEBUG]: finish: init-network/check-cache: SUCCESS: no cache found
2023-01-24 20:50:48,218 - handlers.py[DEBUG]: Queuing POST to http://10.100.127.223:5248/MAAS/metadata/status/6th3hw, data: {'name': 'init-network/check-cache', 'description': 'no cache found', 'event_type': 'finish', 'origin': 'cloudinit', 'timestamp': 1674593448.2188902, 'result': 'SUCCESS'}
2023-01-24 20:50:48,219 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance