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

Device registration cleanup not working properly #128469

Open
JelmerD opened this issue Oct 15, 2024 · 1 comment
Open

Device registration cleanup not working properly #128469

JelmerD opened this issue Oct 15, 2024 · 1 comment

Comments

@JelmerD
Copy link

JelmerD commented Oct 15, 2024 •
edited
Loading

The problem

After I believe removing my Samsung TV from my home asisstant (as I had to reconfigure it) I dind't find any issues. As far as I know my TV got removed.
After removing my TP-Link M9 from UPnP (because I had to add my X60 instead as router) I dind't experience any issues (as far as I know).

But then I found the following log entries:

I believe this first one got triggered by removing my TV because of the MAC in the bottom, that's in the range of Samsung Electronics Co.,Ltd

Logger: aiohttp.server
Source: /usr/local/lib/python3.12/site-packages/aiohttp/web_protocol.py:448
First occurred: 7:28:15 PM (1 occurrences)
Last logged: 7:28:15 PM

Error handling request
Traceback (most recent call last):
  File "/usr/local/lib/python3.12/site-packages/aiohttp/web_protocol.py", line 477, in _handle_request
    resp = await request_handler(request)
           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.12/site-packages/aiohttp/web_app.py", line 559, in _handle
    return await handler(request)
           ^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.12/site-packages/aiohttp/web_middlewares.py", line 117, in impl
    return await handler(request)
           ^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/src/homeassistant/homeassistant/components/http/security_filter.py", line 92, in security_filter_middleware
    return await handler(request)
           ^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/src/homeassistant/homeassistant/components/http/forwarded.py", line 83, in forwarded_middleware
    return await handler(request)
           ^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/src/homeassistant/homeassistant/components/http/request_context.py", line 26, in request_context_middleware
    return await handler(request)
           ^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/src/homeassistant/homeassistant/components/http/ban.py", line 85, in ban_middleware
    return await handler(request)
           ^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/src/homeassistant/homeassistant/components/http/auth.py", line 242, in auth_middleware
    return await handler(request)
           ^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/src/homeassistant/homeassistant/components/http/headers.py", line 32, in headers_middleware
    response = await handler(request)
               ^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/src/homeassistant/homeassistant/helpers/http.py", line 73, in handle
    result = await handler(request, **request.match_info)
             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/src/homeassistant/homeassistant/components/config/config_entries.py", line 95, in delete
    result = await hass.config_entries.async_remove(entry_id)
             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/src/homeassistant/homeassistant/config_entries.py", line 1843, in async_remove
    dev_reg.async_clear_config_entry(entry_id)
  File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 1241, in async_clear_config_entry
    self.async_update_device(device.id, remove_config_entry_id=config_entry_id)
  File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 977, in async_update_device
    self.async_remove_device(device_id)
  File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 1141, in async_remove_device
    device = self.devices.pop(device_id)
             ^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "<frozen _collections_abc>", line 951, in pop
  File "/usr/src/homeassistant/homeassistant/helpers/registry.py", line 62, in __delitem__
    self._unindex_entry(key)
  File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 613, in _unindex_entry
    super()._unindex_entry(key, replacement_entry)
  File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 552, in _unindex_entry
    del self._connections[connection]
        ~~~~~~~~~~~~~~~~~^^^^^^^^^^^^
KeyError: ('mac', '24:fc:e5:xx:xx:xx')

Then I got the following errors a couple of times (added and removed my router a couple of times to see when it triggers):

Logger: homeassistant.helpers.device_registry
Source: helpers/debounce.py:134
First occurred: 7:28:16 PM (5 occurrences)
Last logged: 7:42:49 PM

Unexpected exception from <function async_setup_cleanup.<locals>._async_cleanup at 0x7fa1aed3a0>
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/helpers/debounce.py", line 134, in _handle_timer_finish
    if task := self.hass.async_run_hass_job(
               ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/src/homeassistant/homeassistant/core.py", line 937, in async_run_hass_job
    hassjob.target(*args)
  File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 1437, in _async_cleanup
    async_cleanup(hass, dev_reg, ent_reg)
  File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 1400, in async_cleanup
    dev_reg.async_update_device(
  File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 977, in async_update_device
    self.async_remove_device(device_id)
  File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 1141, in async_remove_device
    device = self.devices.pop(device_id)
             ^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "<frozen _collections_abc>", line 951, in pop
  File "/usr/src/homeassistant/homeassistant/helpers/registry.py", line 62, in __delitem__
    self._unindex_entry(key)
  File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 607, in _unindex_entry
    self._unindex_entry_value(key, area_id, self._area_id_index)
  File "/usr/src/homeassistant/homeassistant/helpers/registry.py", line 56, in _unindex_entry_value
    del entries[key]
        ~~~~~~~^^^^^
KeyError: '142a2f7e801102f975b2618a4776b1ba'

In order to test what's happening I tried to remove one of my Sonos devices, but then I got a completely different error. I'm not sure if it has anything to do with it, or if I'm actually just not allowed to remove the device from HA. Anyhow, I'll just post it as I'm not sure if it is of any help.

Logger: homeassistant.components.websocket_api.http.connection
Source: components/websocket_api/connection.py:307
integration: Home Assistant WebSocket API (documentation, issues)
First occurred: 7:41:11 PM (1 occurrences)
Last logged: 7:41:11 PM

[547633017856] Error handling message: Failed to remove device entry, rejected by integration (home_assistant_error) USERNAME from 192.168.100.119 (Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36)

A little side information. I have been experiencing some issues after updating to version 2024.10.1, I think I got something messed up and had to reflash my SD card. I then rolled back to a full backup which I created right after I setup Nginx and finally got my outside connection to work properly. Therefore, I'm not sure if anything got damaged or if this is an actual bug in the HA core.

Ps. When Googling the issue I found these issues. It seems related. #128264 and #126961

What version of Home Assistant Core has the issue?

core-2024.10.2

What was the last working version of Home Assistant Core?

Not sure, I think 2024-9.x or 2024-10.1

What type of installation are you running?

Home Assistant OS

Integration causing the issue

Devices, HTTP, UPnP

Link to integration documentation on our website

No response

Diagnostics information

No response

Example YAML snippet

No response

Anything in the logs that might be useful for us?

Had Debug logging running whilst removing the router again. Maybe this helps?


2024-10-15 20:06:41.994 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:service:WANIPConnection:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANIPConnection:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:41.994 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.1', 43174), NT: urn:schemas-upnp-org:service:WANIPConnection:1, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANIPConnection:1, location: http://192.168.100.1:1900/oqryp/rootDesc.xml
2024-10-15 20:06:41.994 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:service:WANIPConnection:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANIPConnection:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:41.994 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:service:WANIPConnection:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANIPConnection:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:41.994 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:service:WANIPConnection:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANIPConnection:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:41.994 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), NT: urn:schemas-upnp-org:service:WANIPConnection:1, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANIPConnection:1, location: http://[::1]:1900/oqryp/rootDesc.xml
2024-10-15 20:06:41.994 DEBUG (MainThread) [async_upnp_client.ssdp_listener] Received invalid advertisement headers: {'HOST': '[FF02::C]:1900', 'CACHE-CONTROL': 'max-age=1800', 'LOCATION': 'http://[::1]:1900/oqryp/rootDesc.xml', 'SERVER': 'TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8', 'NT': 'urn:schemas-upnp-org:service:WANIPConnection:1', 'USN': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANIPConnection:1', 'NTS': 'ssdp:alive', 'OPT': '"http://schemas.upnp.org/upnp/1/0/"; ns=01', '01-NLS': '1', 'BOOTID.UPNP.ORG': '1', 'CONFIGID.UPNP.ORG': '1337', '_host': 'fe80::2223:51ff:fe1f:56a4%2', '_udn': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', '_location_original': 'http://[::1]:1900/oqryp/rootDesc.xml', 'location': 'http://[::1]:1900/oqryp/rootDesc.xml', '_timestamp': datetime.datetime(2024, 10, 15, 20, 6, 41, 994690), '_remote_addr': ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), '_port': 59919, '_local_addr': ('::', 1900, 0, 0), '_source': <SsdpSource.ADVERTISEMENT: 'advertisement'>}
2024-10-15 20:06:42.349 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.115', 1900): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=100\r\nLOCATION: http://192.168.100.115:80/description.xml\r\nSERVER: Hue/1.0 UPnP/1.0 IpBridge/1.67.0\r\nNTS: ssdp:alive\r\nhue-bridgeid: ECB5FAFFFE03652D\r\nNT: upnp:rootdevice\r\nUSN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d::upnp:rootdevice\r\n\r\n'
2024-10-15 20:06:42.349 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.115', 1900), NT: upnp:rootdevice, NTS: ssdp:alive, USN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d::upnp:rootdevice, location: http://192.168.100.115:80/description.xml
2024-10-15 20:06:42.349 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.115', 1900): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=100\r\nLOCATION: http://192.168.100.115:80/description.xml\r\nSERVER: Hue/1.0 UPnP/1.0 IpBridge/1.67.0\r\nNTS: ssdp:alive\r\nhue-bridgeid: ECB5FAFFFE03652D\r\nNT: upnp:rootdevice\r\nUSN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d::upnp:rootdevice\r\n\r\n'
2024-10-15 20:06:42.400 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.115', 1900): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=100\r\nLOCATION: http://192.168.100.115:80/description.xml\r\nSERVER: Hue/1.0 UPnP/1.0 IpBridge/1.67.0\r\nNTS: ssdp:alive\r\nhue-bridgeid: ECB5FAFFFE03652D\r\nNT: upnp:rootdevice\r\nUSN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d::upnp:rootdevice\r\n\r\n'
2024-10-15 20:06:42.400 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.115', 1900), NT: upnp:rootdevice, NTS: ssdp:alive, USN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d::upnp:rootdevice, location: http://192.168.100.115:80/description.xml
2024-10-15 20:06:42.400 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.115', 1900): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=100\r\nLOCATION: http://192.168.100.115:80/description.xml\r\nSERVER: Hue/1.0 UPnP/1.0 IpBridge/1.67.0\r\nNTS: ssdp:alive\r\nhue-bridgeid: ECB5FAFFFE03652D\r\nNT: upnp:rootdevice\r\nUSN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d::upnp:rootdevice\r\n\r\n'
2024-10-15 20:06:42.450 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.115', 1900): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=100\r\nLOCATION: http://192.168.100.115:80/description.xml\r\nSERVER: Hue/1.0 UPnP/1.0 IpBridge/1.67.0\r\nNTS: ssdp:alive\r\nhue-bridgeid: ECB5FAFFFE03652D\r\nNT: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d\r\nUSN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d\r\n\r\n'
2024-10-15 20:06:42.450 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.115', 1900), NT: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d, NTS: ssdp:alive, USN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d, location: http://192.168.100.115:80/description.xml
2024-10-15 20:06:42.451 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.115', 1900): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=100\r\nLOCATION: http://192.168.100.115:80/description.xml\r\nSERVER: Hue/1.0 UPnP/1.0 IpBridge/1.67.0\r\nNTS: ssdp:alive\r\nhue-bridgeid: ECB5FAFFFE03652D\r\nNT: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d\r\nUSN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d\r\n\r\n'
2024-10-15 20:06:42.500 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.115', 1900): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=100\r\nLOCATION: http://192.168.100.115:80/description.xml\r\nSERVER: Hue/1.0 UPnP/1.0 IpBridge/1.67.0\r\nNTS: ssdp:alive\r\nhue-bridgeid: ECB5FAFFFE03652D\r\nNT: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d\r\nUSN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d\r\n\r\n'
2024-10-15 20:06:42.500 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.115', 1900), NT: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d, NTS: ssdp:alive, USN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d, location: http://192.168.100.115:80/description.xml
2024-10-15 20:06:42.500 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.115', 1900): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=100\r\nLOCATION: http://192.168.100.115:80/description.xml\r\nSERVER: Hue/1.0 UPnP/1.0 IpBridge/1.67.0\r\nNTS: ssdp:alive\r\nhue-bridgeid: ECB5FAFFFE03652D\r\nNT: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d\r\nUSN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d\r\n\r\n'
2024-10-15 20:06:42.550 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.115', 1900): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=100\r\nLOCATION: http://192.168.100.115:80/description.xml\r\nSERVER: Hue/1.0 UPnP/1.0 IpBridge/1.67.0\r\nNTS: ssdp:alive\r\nhue-bridgeid: ECB5FAFFFE03652D\r\nNT: urn:schemas-upnp-org:device:basic:1\r\nUSN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d\r\n\r\n'
2024-10-15 20:06:42.551 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.115', 1900), NT: urn:schemas-upnp-org:device:basic:1, NTS: ssdp:alive, USN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d, location: http://192.168.100.115:80/description.xml
2024-10-15 20:06:42.551 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.115', 1900): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=100\r\nLOCATION: http://192.168.100.115:80/description.xml\r\nSERVER: Hue/1.0 UPnP/1.0 IpBridge/1.67.0\r\nNTS: ssdp:alive\r\nhue-bridgeid: ECB5FAFFFE03652D\r\nNT: urn:schemas-upnp-org:device:basic:1\r\nUSN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d\r\n\r\n'
2024-10-15 20:06:42.601 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.115', 1900): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=100\r\nLOCATION: http://192.168.100.115:80/description.xml\r\nSERVER: Hue/1.0 UPnP/1.0 IpBridge/1.67.0\r\nNTS: ssdp:alive\r\nhue-bridgeid: ECB5FAFFFE03652D\r\nNT: urn:schemas-upnp-org:device:basic:1\r\nUSN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d\r\n\r\n'
2024-10-15 20:06:42.602 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.115', 1900), NT: urn:schemas-upnp-org:device:basic:1, NTS: ssdp:alive, USN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d, location: http://192.168.100.115:80/description.xml
2024-10-15 20:06:42.602 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.115', 1900): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=100\r\nLOCATION: http://192.168.100.115:80/description.xml\r\nSERVER: Hue/1.0 UPnP/1.0 IpBridge/1.67.0\r\nNTS: ssdp:alive\r\nhue-bridgeid: ECB5FAFFFE03652D\r\nNT: urn:schemas-upnp-org:device:basic:1\r\nUSN: uuid:2f402f80-da50-11e1-9b23-ecb5fa03652d\r\n\r\n'
2024-10-15 20:06:45.994 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:service:WANPPPConnection:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANPPPConnection:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:45.994 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.1', 43174), NT: urn:schemas-upnp-org:service:WANPPPConnection:1, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANPPPConnection:1, location: http://192.168.100.1:1900/oqryp/rootDesc.xml
2024-10-15 20:06:45.994 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:service:WANPPPConnection:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANPPPConnection:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:45.995 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:service:WANPPPConnection:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANPPPConnection:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:45.995 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:service:WANPPPConnection:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANPPPConnection:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:45.996 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), NT: urn:schemas-upnp-org:service:WANPPPConnection:1, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANPPPConnection:1, location: http://[::1]:1900/oqryp/rootDesc.xml
2024-10-15 20:06:45.996 DEBUG (MainThread) [async_upnp_client.ssdp_listener] Received invalid advertisement headers: {'HOST': '[FF02::C]:1900', 'CACHE-CONTROL': 'max-age=1800', 'LOCATION': 'http://[::1]:1900/oqryp/rootDesc.xml', 'SERVER': 'TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8', 'NT': 'urn:schemas-upnp-org:service:WANPPPConnection:1', 'USN': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:WANPPPConnection:1', 'NTS': 'ssdp:alive', 'OPT': '"http://schemas.upnp.org/upnp/1/0/"; ns=01', '01-NLS': '1', 'BOOTID.UPNP.ORG': '1', 'CONFIGID.UPNP.ORG': '1337', '_host': 'fe80::2223:51ff:fe1f:56a4%2', '_udn': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', '_location_original': 'http://[::1]:1900/oqryp/rootDesc.xml', 'location': 'http://[::1]:1900/oqryp/rootDesc.xml', '_timestamp': datetime.datetime(2024, 10, 15, 20, 6, 45, 995975), '_remote_addr': ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), '_port': 59919, '_local_addr': ('::', 1900, 0, 0), '_source': <SsdpSource.ADVERTISEMENT: 'advertisement'>}
2024-10-15 20:06:48.003 DEBUG (MainThread) [async_upnp_client.server] Announcing
2024-10-15 20:06:48.003 DEBUG (MainThread) [async_upnp_client.server] Sending advertisement, NTS: ssdp:alive, NT: urn:home-assistant.io:device:HomeAssistant:1, USN: UUID:D6B1445A-6EDE-4F8F-913B-CFC32498FAC2::urn:home-assistant.io:device:HomeAssistant:1
2024-10-15 20:06:48.003 DEBUG (MainThread) [async_upnp_client.ssdp] Sending SSDP packet, transport: <_SelectorDatagramTransport fd=66 read=polling write=<idle, bufsize=0>>, socket: <asyncio.TransportSocket fd=66, family=2, type=2, proto=0, laddr=('0.0.0.0', 53559)>, target: ('239.255.255.250', 1900)
2024-10-15 20:06:48.003 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Sending SSDP packet, target: ('239.255.255.250', 1900), data: b'NOTIFY * HTTP/1.1\r\nNTS:ssdp:alive\r\nHOST:239.255.255.250:1900\r\nCACHE-CONTROL:max-age=1800\r\nSERVER:async-upnp-client/0.40.0 UPnP/2.0 Server/1.0\r\nBOOTID.UPNP.ORG:1729012577\r\nCONFIGID.UPNP.ORG:1\r\nLOCATION:http://192.168.100.100:40000/device.xml\r\nNT:urn:home-assistant.io:device:HomeAssistant:1\r\nUSN:UUID:D6B1445A-6EDE-4F8F-913B-CFC32498FAC2::urn:home-assistant.io:device:HomeAssistant:1\r\n\r\n'
2024-10-15 20:06:48.003 DEBUG (MainThread) [async_upnp_client.server] Announcing
2024-10-15 20:06:48.004 DEBUG (MainThread) [async_upnp_client.server] Sending advertisement, NTS: ssdp:alive, NT: urn:home-assistant.io:device:HomeAssistant:1, USN: UUID:D6B1445A-6EDE-4F8F-913B-CFC32498FAC2::urn:home-assistant.io:device:HomeAssistant:1
2024-10-15 20:06:48.004 DEBUG (MainThread) [async_upnp_client.ssdp] Sending SSDP packet, transport: <_SelectorDatagramTransport fd=74 read=polling write=<idle, bufsize=0>>, socket: <asyncio.TransportSocket fd=74, family=10, type=2, proto=0, laddr=('::', 53180, 0, 0)>, target: ('FF02::C', 1900, 0, 2)
2024-10-15 20:06:48.004 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Sending SSDP packet, target: ('FF02::C', 1900, 0, 2), data: b'NOTIFY * HTTP/1.1\r\nNTS:ssdp:alive\r\nHOST:[FF02::C]:1900\r\nCACHE-CONTROL:max-age=1800\r\nSERVER:async-upnp-client/0.40.0 UPnP/2.0 Server/1.0\r\nBOOTID.UPNP.ORG:1729012577\r\nCONFIGID.UPNP.ORG:1\r\nLOCATION:http://[fe80::251c:c91f:222:242a]:40000/device.xml\r\nNT:urn:home-assistant.io:device:HomeAssistant:1\r\nUSN:UUID:D6B1445A-6EDE-4F8F-913B-CFC32498FAC2::urn:home-assistant.io:device:HomeAssistant:1\r\n\r\n'
2024-10-15 20:06:48.004 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.100', 53559): b'NOTIFY * HTTP/1.1\r\nNTS:ssdp:alive\r\nHOST:239.255.255.250:1900\r\nCACHE-CONTROL:max-age=1800\r\nSERVER:async-upnp-client/0.40.0 UPnP/2.0 Server/1.0\r\nBOOTID.UPNP.ORG:1729012577\r\nCONFIGID.UPNP.ORG:1\r\nLOCATION:http://192.168.100.100:40000/device.xml\r\nNT:urn:home-assistant.io:device:HomeAssistant:1\r\nUSN:UUID:D6B1445A-6EDE-4F8F-913B-CFC32498FAC2::urn:home-assistant.io:device:HomeAssistant:1\r\n\r\n'
2024-10-15 20:06:48.004 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.100', 53559), NT: urn:home-assistant.io:device:HomeAssistant:1, NTS: ssdp:alive, USN: UUID:D6B1445A-6EDE-4F8F-913B-CFC32498FAC2::urn:home-assistant.io:device:HomeAssistant:1, location: http://192.168.100.100:40000/device.xml
2024-10-15 20:06:48.004 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.100', 53559): b'NOTIFY * HTTP/1.1\r\nNTS:ssdp:alive\r\nHOST:239.255.255.250:1900\r\nCACHE-CONTROL:max-age=1800\r\nSERVER:async-upnp-client/0.40.0 UPnP/2.0 Server/1.0\r\nBOOTID.UPNP.ORG:1729012577\r\nCONFIGID.UPNP.ORG:1\r\nLOCATION:http://192.168.100.100:40000/device.xml\r\nNT:urn:home-assistant.io:device:HomeAssistant:1\r\nUSN:UUID:D6B1445A-6EDE-4F8F-913B-CFC32498FAC2::urn:home-assistant.io:device:HomeAssistant:1\r\n\r\n'
2024-10-15 20:06:48.005 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::251c:c91f:222:242a', 53180, 0, 2): b'NOTIFY * HTTP/1.1\r\nNTS:ssdp:alive\r\nHOST:[FF02::C]:1900\r\nCACHE-CONTROL:max-age=1800\r\nSERVER:async-upnp-client/0.40.0 UPnP/2.0 Server/1.0\r\nBOOTID.UPNP.ORG:1729012577\r\nCONFIGID.UPNP.ORG:1\r\nLOCATION:http://[fe80::251c:c91f:222:242a]:40000/device.xml\r\nNT:urn:home-assistant.io:device:HomeAssistant:1\r\nUSN:UUID:D6B1445A-6EDE-4F8F-913B-CFC32498FAC2::urn:home-assistant.io:device:HomeAssistant:1\r\n\r\n'
2024-10-15 20:06:48.005 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::251c:c91f:222:242a', 53180, 0, 2): b'NOTIFY * HTTP/1.1\r\nNTS:ssdp:alive\r\nHOST:[FF02::C]:1900\r\nCACHE-CONTROL:max-age=1800\r\nSERVER:async-upnp-client/0.40.0 UPnP/2.0 Server/1.0\r\nBOOTID.UPNP.ORG:1729012577\r\nCONFIGID.UPNP.ORG:1\r\nLOCATION:http://[fe80::251c:c91f:222:242a]:40000/device.xml\r\nNT:urn:home-assistant.io:device:HomeAssistant:1\r\nUSN:UUID:D6B1445A-6EDE-4F8F-913B-CFC32498FAC2::urn:home-assistant.io:device:HomeAssistant:1\r\n\r\n'
2024-10-15 20:06:48.005 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('fe80::251c:c91f:222:242a', 53180, 0, 2), NT: urn:home-assistant.io:device:HomeAssistant:1, NTS: ssdp:alive, USN: UUID:D6B1445A-6EDE-4F8F-913B-CFC32498FAC2::urn:home-assistant.io:device:HomeAssistant:1, location: http://[fe80::251c:c91f:222:242a%2]:40000/device.xml
2024-10-15 20:06:48.994 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:service:Layer3Forwarding:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:Layer3Forwarding:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:48.994 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.1', 43174), NT: urn:schemas-upnp-org:service:Layer3Forwarding:1, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:Layer3Forwarding:1, location: http://192.168.100.1:1900/oqryp/rootDesc.xml
2024-10-15 20:06:48.995 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:service:Layer3Forwarding:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:Layer3Forwarding:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:48.995 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:service:Layer3Forwarding:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:Layer3Forwarding:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:48.995 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:service:Layer3Forwarding:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:Layer3Forwarding:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:48.995 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), NT: urn:schemas-upnp-org:service:Layer3Forwarding:1, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:Layer3Forwarding:1, location: http://[::1]:1900/oqryp/rootDesc.xml
2024-10-15 20:06:48.995 DEBUG (MainThread) [async_upnp_client.ssdp_listener] Received invalid advertisement headers: {'HOST': '[FF02::C]:1900', 'CACHE-CONTROL': 'max-age=1800', 'LOCATION': 'http://[::1]:1900/oqryp/rootDesc.xml', 'SERVER': 'TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8', 'NT': 'urn:schemas-upnp-org:service:Layer3Forwarding:1', 'USN': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:service:Layer3Forwarding:1', 'NTS': 'ssdp:alive', 'OPT': '"http://schemas.upnp.org/upnp/1/0/"; ns=01', '01-NLS': '1', 'BOOTID.UPNP.ORG': '1', 'CONFIGID.UPNP.ORG': '1337', '_host': 'fe80::2223:51ff:fe1f:56a4%2', '_udn': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', '_location_original': 'http://[::1]:1900/oqryp/rootDesc.xml', 'location': 'http://[::1]:1900/oqryp/rootDesc.xml', '_timestamp': datetime.datetime(2024, 10, 15, 20, 6, 48, 995553), '_remote_addr': ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), '_port': 59919, '_local_addr': ('::', 1900, 0, 0), '_source': <SsdpSource.ADVERTISEMENT: 'advertisement'>}
2024-10-15 20:06:51.994 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: upnp:rootdevice\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::upnp:rootdevice\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:51.995 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.1', 43174), NT: upnp:rootdevice, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::upnp:rootdevice, location: http://192.168.100.1:1900/oqryp/rootDesc.xml
2024-10-15 20:06:51.995 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: upnp:rootdevice\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::upnp:rootdevice\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:51.995 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:51.995 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.1', 43174), NT: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89, location: http://192.168.100.1:1900/oqryp/rootDesc.xml
2024-10-15 20:06:51.995 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:51.996 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: upnp:rootdevice\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::upnp:rootdevice\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:51.996 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: upnp:rootdevice\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::upnp:rootdevice\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:51.996 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), NT: upnp:rootdevice, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::upnp:rootdevice, location: http://[::1]:1900/oqryp/rootDesc.xml
2024-10-15 20:06:51.996 DEBUG (MainThread) [async_upnp_client.ssdp_listener] Received invalid advertisement headers: {'HOST': '[FF02::C]:1900', 'CACHE-CONTROL': 'max-age=1800', 'LOCATION': 'http://[::1]:1900/oqryp/rootDesc.xml', 'SERVER': 'TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8', 'NT': 'upnp:rootdevice', 'USN': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::upnp:rootdevice', 'NTS': 'ssdp:alive', 'OPT': '"http://schemas.upnp.org/upnp/1/0/"; ns=01', '01-NLS': '1', 'BOOTID.UPNP.ORG': '1', 'CONFIGID.UPNP.ORG': '1337', '_host': 'fe80::2223:51ff:fe1f:56a4%2', '_udn': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', '_location_original': 'http://[::1]:1900/oqryp/rootDesc.xml', 'location': 'http://[::1]:1900/oqryp/rootDesc.xml', '_timestamp': datetime.datetime(2024, 10, 15, 20, 6, 51, 996308), '_remote_addr': ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), '_port': 59919, '_local_addr': ('::', 1900, 0, 0), '_source': <SsdpSource.ADVERTISEMENT: 'advertisement'>}
2024-10-15 20:06:51.996 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:51.996 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:51.996 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), NT: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89, location: http://[::1]:1900/oqryp/rootDesc.xml
2024-10-15 20:06:51.997 DEBUG (MainThread) [async_upnp_client.ssdp_listener] Received invalid advertisement headers: {'HOST': '[FF02::C]:1900', 'CACHE-CONTROL': 'max-age=1800', 'LOCATION': 'http://[::1]:1900/oqryp/rootDesc.xml', 'SERVER': 'TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8', 'NT': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', 'USN': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', 'NTS': 'ssdp:alive', 'OPT': '"http://schemas.upnp.org/upnp/1/0/"; ns=01', '01-NLS': '1', 'BOOTID.UPNP.ORG': '1', 'CONFIGID.UPNP.ORG': '1337', '_host': 'fe80::2223:51ff:fe1f:56a4%2', '_udn': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', '_location_original': 'http://[::1]:1900/oqryp/rootDesc.xml', 'location': 'http://[::1]:1900/oqryp/rootDesc.xml', '_timestamp': datetime.datetime(2024, 10, 15, 20, 6, 51, 996973), '_remote_addr': ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), '_port': 59919, '_local_addr': ('::', 1900, 0, 0), '_source': <SsdpSource.ADVERTISEMENT: 'advertisement'>}
2024-10-15 20:06:53.424 DEBUG (MainThread) [homeassistant.components.upnp] Getting data for device: IGD Device: X60/uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:InternetGatewayDevice:1, state_items: {<IgdStateItem.BYTES_RECEIVED: 1>, <IgdStateItem.BYTES_SENT: 2>, <IgdStateItem.EXTERNAL_IP_ADDRESS: 8>}, force_poll: False
2024-10-15 20:06:53.425 DEBUG (MainThread) [async_upnp_client.client] Calling action: GetTotalBytesReceived, args: {}
2024-10-15 20:06:53.425 DEBUG (MainThread) [async_upnp_client.traffic.upnp] Sending request:
POST http://192.168.100.1:1900/oqryp/ctl/CmnIfCfg
SOAPAction: "urn:schemas-upnp-org:service:WANCommonInterfaceConfig:1#GetTotalBytesReceived"
Host: 192.168.100.1:1900
Content-Type: text/xml; charset="utf-8"
<?xml version="1.0"?><s:Envelope s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/" xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"><s:Body><u:GetTotalBytesReceived xmlns:u="urn:schemas-upnp-org:service:WANCommonInterfaceConfig:1"></u:GetTotalBytesReceived></s:Body></s:Envelope>

2024-10-15 20:06:53.425 DEBUG (MainThread) [async_upnp_client.client] Calling action: GetTotalBytesSent, args: {}
2024-10-15 20:06:53.425 DEBUG (MainThread) [async_upnp_client.traffic.upnp] Sending request:
POST http://192.168.100.1:1900/oqryp/ctl/CmnIfCfg
SOAPAction: "urn:schemas-upnp-org:service:WANCommonInterfaceConfig:1#GetTotalBytesSent"
Host: 192.168.100.1:1900
Content-Type: text/xml; charset="utf-8"
<?xml version="1.0"?><s:Envelope s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/" xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"><s:Body><u:GetTotalBytesSent xmlns:u="urn:schemas-upnp-org:service:WANCommonInterfaceConfig:1"></u:GetTotalBytesSent></s:Body></s:Envelope>

2024-10-15 20:06:53.431 DEBUG (MainThread) [async_upnp_client.traffic.upnp] Got response from POST http://192.168.100.1:1900/oqryp/ctl/CmnIfCfg:
200
Content-Type: text/xml; charset="utf-8"
Connection: close
Content-Length: 370
Server: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8
Ext: 

b'<?xml version="1.0"?>\r\n<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetTotalBytesReceivedResponse xmlns:u="urn:schemas-upnp-org:service:WANCommonInterfaceConfig:1"><NewTotalBytesReceived>16401475806</NewTotalBytesReceived></u:GetTotalBytesReceivedResponse></s:Body></s:Envelope>\r\n'
2024-10-15 20:06:53.431 DEBUG (MainThread) [async_upnp_client.client] Called action: GetTotalBytesReceived, args: {}, response_args: {'NewTotalBytesReceived': 16401475806}
2024-10-15 20:06:53.432 DEBUG (MainThread) [async_upnp_client.traffic.upnp] Got response from POST http://192.168.100.1:1900/oqryp/ctl/CmnIfCfg:
200
Content-Type: text/xml; charset="utf-8"
Connection: close
Content-Length: 352
Server: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8
Ext: 

b'<?xml version="1.0"?>\r\n<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetTotalBytesSentResponse xmlns:u="urn:schemas-upnp-org:service:WANCommonInterfaceConfig:1"><NewTotalBytesSent>922218019</NewTotalBytesSent></u:GetTotalBytesSentResponse></s:Body></s:Envelope>\r\n'
2024-10-15 20:06:53.433 DEBUG (MainThread) [async_upnp_client.client] Called action: GetTotalBytesSent, args: {}, response_args: {'NewTotalBytesSent': 922218019}
2024-10-15 20:06:53.433 DEBUG (MainThread) [homeassistant.components.upnp] Finished fetching X60 data in 0.009 seconds (success: True)
2024-10-15 20:06:55.995 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:device:InternetGatewayDevice:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:InternetGatewayDevice:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:55.995 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.1', 43174), NT: urn:schemas-upnp-org:device:InternetGatewayDevice:1, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:InternetGatewayDevice:1, location: http://192.168.100.1:1900/oqryp/rootDesc.xml
2024-10-15 20:06:55.995 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:device:InternetGatewayDevice:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:InternetGatewayDevice:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:55.996 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:device:InternetGatewayDevice:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:InternetGatewayDevice:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:55.997 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:device:InternetGatewayDevice:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:InternetGatewayDevice:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:55.997 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), NT: urn:schemas-upnp-org:device:InternetGatewayDevice:1, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:InternetGatewayDevice:1, location: http://[::1]:1900/oqryp/rootDesc.xml
2024-10-15 20:06:55.997 DEBUG (MainThread) [async_upnp_client.ssdp_listener] Received invalid advertisement headers: {'HOST': '[FF02::C]:1900', 'CACHE-CONTROL': 'max-age=1800', 'LOCATION': 'http://[::1]:1900/oqryp/rootDesc.xml', 'SERVER': 'TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8', 'NT': 'urn:schemas-upnp-org:device:InternetGatewayDevice:1', 'USN': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:InternetGatewayDevice:1', 'NTS': 'ssdp:alive', 'OPT': '"http://schemas.upnp.org/upnp/1/0/"; ns=01', '01-NLS': '1', 'BOOTID.UPNP.ORG': '1', 'CONFIGID.UPNP.ORG': '1337', '_host': 'fe80::2223:51ff:fe1f:56a4%2', '_udn': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', '_location_original': 'http://[::1]:1900/oqryp/rootDesc.xml', 'location': 'http://[::1]:1900/oqryp/rootDesc.xml', '_timestamp': datetime.datetime(2024, 10, 15, 20, 6, 55, 997216), '_remote_addr': ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), '_port': 59919, '_local_addr': ('::', 1900, 0, 0), '_source': <SsdpSource.ADVERTISEMENT: 'advertisement'>}
2024-10-15 20:06:57.387 DEBUG (MainThread) [homeassistant.components.upnp] Unloading config entry: 01JA8MP8TK567GGG30K5JY0SGJ
2024-10-15 20:06:57.388 DEBUG (MainThread) [async_upnp_client.profiles.profile] Cancelling resubscribe_task
2024-10-15 20:06:57.390 DEBUG (MainThread) [async_upnp_client.event_handler] Unsubscribing from SID: uuid:1caf909a-dd92-4555-86c4-a3bb27292697, service: <UpnpService(urn:upnp-org:serviceId:Layer3Forwarding1, uuid:1caf909a-dd92-4555-86c4-a3bb27292a89)> device: <UpnpDevice(uuid:1caf909a-dd92-4555-86c4-a3bb27292a89)>
2024-10-15 20:06:57.390 DEBUG (MainThread) [async_upnp_client.traffic.upnp] Sending request:
UNSUBSCRIBE http://192.168.100.1:1900/oqryp/evt/L3F
HOST: 192.168.100.1:1900
SID: uuid:1caf909a-dd92-4555-86c4-a3bb27292697


2024-10-15 20:06:57.390 DEBUG (MainThread) [async_upnp_client.event_handler] Unsubscribing from SID: uuid:1caf909a-dd92-4555-86c4-a3bb27291634, service: <UpnpService(urn:upnp-org:serviceId:WANCommonIFC1, uuid:1caf909a-dd92-4555-86c4-a3bb27292a89)> device: <UpnpDevice(uuid:1caf909a-dd92-4555-86c4-a3bb27292a89)>
2024-10-15 20:06:57.391 DEBUG (MainThread) [async_upnp_client.traffic.upnp] Sending request:
UNSUBSCRIBE http://192.168.100.1:1900/oqryp/evt/CmnIfCfg
HOST: 192.168.100.1:1900
SID: uuid:1caf909a-dd92-4555-86c4-a3bb27291634


2024-10-15 20:06:57.391 DEBUG (MainThread) [async_upnp_client.event_handler] Unsubscribing from SID: uuid:1caf909a-dd92-4555-86c4-a3bb2729c491, service: <UpnpService(urn:upnp-org:serviceId:WANIPConn1, uuid:1caf909a-dd92-4555-86c4-a3bb27292a89)> device: <UpnpDevice(uuid:1caf909a-dd92-4555-86c4-a3bb27292a89)>
2024-10-15 20:06:57.391 DEBUG (MainThread) [async_upnp_client.traffic.upnp] Sending request:
UNSUBSCRIBE http://192.168.100.1:1900/oqryp/evt/IPConn
HOST: 192.168.100.1:1900
SID: uuid:1caf909a-dd92-4555-86c4-a3bb2729c491


2024-10-15 20:06:57.396 DEBUG (MainThread) [async_upnp_client.traffic.upnp] Got response from UNSUBSCRIBE http://192.168.100.1:1900/oqryp/evt/IPConn:
200
Content-Type: text/xml; charset="utf-8"
Connection: close
Content-Length: 0
Server: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8
Ext: 

b''
2024-10-15 20:06:57.397 DEBUG (MainThread) [async_upnp_client.traffic.upnp] Got response from UNSUBSCRIBE http://192.168.100.1:1900/oqryp/evt/L3F:
200
Content-Type: text/xml; charset="utf-8"
Connection: close
Content-Length: 0
Server: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8
Ext: 

b''
2024-10-15 20:06:57.398 DEBUG (MainThread) [async_upnp_client.traffic.upnp] Got response from UNSUBSCRIBE http://192.168.100.1:1900/oqryp/evt/CmnIfCfg:
200
Content-Type: text/xml; charset="utf-8"
Connection: close
Content-Length: 0
Server: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8
Ext: 

b''
2024-10-15 20:06:57.401 DEBUG (MainThread) [homeassistant.components.upnp] async_step_ssdp: discovery_info: SsdpServiceInfo(ssdp_usn='uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:InternetGatewayDevice:1', ssdp_st='urn:schemas-upnp-org:device:InternetGatewayDevice:1', upnp={'deviceType': 'urn:schemas-upnp-org:device:InternetGatewayDevice:1', 'friendlyName': 'X60', 'manufacturer': 'TP-LINK', 'manufacturerURL': 'http://www.tp-link.com/', 'modelDescription': 'X60', 'modelName': 'X60', 'modelNumber': '1.0', 'modelURL': 'http://www.tp-link.com/', 'serialNumber': '00000000', 'UDN': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', 'serviceList': {'service': {'serviceType': 'urn:schemas-upnp-org:service:Layer3Forwarding:1', 'serviceId': 'urn:upnp-org:serviceId:Layer3Forwarding1', 'controlURL': '/oqryp/ctl/L3F', 'eventSubURL': '/oqryp/evt/L3F', 'SCPDURL': '/oqryp/L3F.xml'}}, 'deviceList': {'device': {'deviceType': 'urn:schemas-upnp-org:device:WANDevice:1', 'friendlyName': 'WANDevice', 'manufacturer': 'MiniUPnP', 'manufacturerURL': 'http://miniupnp.free.fr/', 'modelDescription': 'WAN Device', 'modelName': 'WAN Device', 'modelNumber': '20240722', 'modelURL': 'http://miniupnp.free.fr/', 'serialNumber': '00000000', 'UDN': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', 'UPC': '000000000000', 'serviceList': {'service': {'serviceType': 'urn:schemas-upnp-org:service:WANCommonInterfaceConfig:1', 'serviceId': 'urn:upnp-org:serviceId:WANCommonIFC1', 'controlURL': '/oqryp/ctl/CmnIfCfg', 'eventSubURL': '/oqryp/evt/CmnIfCfg', 'SCPDURL': '/oqryp/WANCfg.xml'}}, 'deviceList': {'device': {'deviceType': 'urn:schemas-upnp-org:device:WANConnectionDevice:1', 'friendlyName': 'WANConnectionDevice', 'manufacturer': 'MiniUPnP', 'manufacturerURL': 'http://miniupnp.free.fr/', 'modelDescription': 'MiniUPnP daemon', 'modelName': 'MiniUPnPd', 'modelNumber': '20240722', 'modelURL': 'http://miniupnp.free.fr/', 'serialNumber': '00000000', 'UDN': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', 'UPC': '000000000000', 'serviceList': {'service': {'serviceType': 'urn:schemas-upnp-org:service:WANIPConnection:1', 'serviceId': 'urn:upnp-org:serviceId:WANIPConn1', 'controlURL': '/oqryp/ctl/IPConn', 'eventSubURL': '/oqryp/evt/IPConn', 'SCPDURL': '/oqryp/WANIPCn.xml'}}}}}}, 'presentationURL': 'http://192.168.100.1/'}, ssdp_location='http://192.168.100.1:1900/oqryp/rootDesc.xml', ssdp_nt='urn:schemas-upnp-org:device:InternetGatewayDevice:1', ssdp_udn='uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', ssdp_ext='', ssdp_server='TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8', ssdp_headers={'CACHE-CONTROL': 'max-age=1800', 'ST': 'urn:schemas-upnp-org:device:InternetGatewayDevice:1', 'USN': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:InternetGatewayDevice:1', 'EXT': '', 'SERVER': 'TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8', 'LOCATION': 'http://192.168.100.1:1900/oqryp/rootDesc.xml', 'OPT': '"http://schemas.upnp.org/upnp/1/0/"; ns=01', '01-NLS': '1', 'BOOTID.UPNP.ORG': '1', 'CONFIGID.UPNP.ORG': '1337', '_host': '192.168.100.1', '_udn': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', '_location_original': 'http://192.168.100.1:1900/oqryp/rootDesc.xml', 'location': 'http://192.168.100.1:1900/oqryp/rootDesc.xml', '_timestamp': datetime.datetime(2024, 10, 15, 20, 6, 55, 995636), '_remote_addr': ('192.168.100.1', 43174), '_port': 43174, '_local_addr': ('0.0.0.0', 1900), 'HOST': '239.255.255.250:1900', 'NT': 'urn:schemas-upnp-org:device:InternetGatewayDevice:1', 'NTS': 'ssdp:alive'}, ssdp_all_locations={'http://192.168.100.1:1900/oqryp/rootDesc.xml'}, x_homeassistant_matching_domains={'upnp'})
2024-10-15 20:06:57.407 DEBUG (MainThread) [homeassistant.components.upnp] async_step_ssdp_confirm: user_input: None
2024-10-15 20:06:59.995 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:device:WANConnectionDevice:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANConnectionDevice:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:59.995 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.1', 43174), NT: urn:schemas-upnp-org:device:WANConnectionDevice:1, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANConnectionDevice:1, location: http://192.168.100.1:1900/oqryp/rootDesc.xml
2024-10-15 20:06:59.996 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:device:WANConnectionDevice:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANConnectionDevice:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:59.996 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:device:WANConnectionDevice:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANConnectionDevice:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:59.996 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:device:WANConnectionDevice:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANConnectionDevice:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:06:59.996 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), NT: urn:schemas-upnp-org:device:WANConnectionDevice:1, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANConnectionDevice:1, location: http://[::1]:1900/oqryp/rootDesc.xml
2024-10-15 20:06:59.996 DEBUG (MainThread) [async_upnp_client.ssdp_listener] Received invalid advertisement headers: {'HOST': '[FF02::C]:1900', 'CACHE-CONTROL': 'max-age=1800', 'LOCATION': 'http://[::1]:1900/oqryp/rootDesc.xml', 'SERVER': 'TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8', 'NT': 'urn:schemas-upnp-org:device:WANConnectionDevice:1', 'USN': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANConnectionDevice:1', 'NTS': 'ssdp:alive', 'OPT': '"http://schemas.upnp.org/upnp/1/0/"; ns=01', '01-NLS': '1', 'BOOTID.UPNP.ORG': '1', 'CONFIGID.UPNP.ORG': '1337', '_host': 'fe80::2223:51ff:fe1f:56a4%2', '_udn': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', '_location_original': 'http://[::1]:1900/oqryp/rootDesc.xml', 'location': 'http://[::1]:1900/oqryp/rootDesc.xml', '_timestamp': datetime.datetime(2024, 10, 15, 20, 6, 59, 996608), '_remote_addr': ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), '_port': 59919, '_local_addr': ('::', 1900, 0, 0), '_source': <SsdpSource.ADVERTISEMENT: 'advertisement'>}
2024-10-15 20:07:03.995 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:device:WANDevice:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANDevice:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:07:03.996 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('192.168.100.1', 43174), NT: urn:schemas-upnp-org:device:WANDevice:1, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANDevice:1, location: http://192.168.100.1:1900/oqryp/rootDesc.xml
2024-10-15 20:07:03.996 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('192.168.100.1', 43174): b'NOTIFY * HTTP/1.1\r\nHOST: 239.255.255.250:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://192.168.100.1:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:device:WANDevice:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANDevice:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:07:03.996 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:device:WANDevice:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANDevice:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:07:03.996 DEBUG (MainThread) [async_upnp_client.traffic.ssdp] Received packet from ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2): b'NOTIFY * HTTP/1.1\r\nHOST: [FF02::C]:1900\r\nCACHE-CONTROL: max-age=1800\r\nLOCATION: http://[::1]:1900/oqryp/rootDesc.xml\r\nSERVER: TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8\r\nNT: urn:schemas-upnp-org:device:WANDevice:1\r\nUSN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANDevice:1\r\nNTS: ssdp:alive\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1\r\nBOOTID.UPNP.ORG: 1\r\nCONFIGID.UPNP.ORG: 1337\r\n\r\n'
2024-10-15 20:07:03.996 DEBUG (MainThread) [async_upnp_client.advertisement] Received advertisement, _remote_addr: ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), NT: urn:schemas-upnp-org:device:WANDevice:1, NTS: ssdp:alive, USN: uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANDevice:1, location: http://[::1]:1900/oqryp/rootDesc.xml
2024-10-15 20:07:03.996 DEBUG (MainThread) [async_upnp_client.ssdp_listener] Received invalid advertisement headers: {'HOST': '[FF02::C]:1900', 'CACHE-CONTROL': 'max-age=1800', 'LOCATION': 'http://[::1]:1900/oqryp/rootDesc.xml', 'SERVER': 'TP-LINK/TP-LINK UPnP/1.1 MiniUPnPd/1.8', 'NT': 'urn:schemas-upnp-org:device:WANDevice:1', 'USN': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89::urn:schemas-upnp-org:device:WANDevice:1', 'NTS': 'ssdp:alive', 'OPT': '"http://schemas.upnp.org/upnp/1/0/"; ns=01', '01-NLS': '1', 'BOOTID.UPNP.ORG': '1', 'CONFIGID.UPNP.ORG': '1337', '_host': 'fe80::2223:51ff:fe1f:56a4%2', '_udn': 'uuid:1caf909a-dd92-4555-86c4-a3bb27292a89', '_location_original': 'http://[::1]:1900/oqryp/rootDesc.xml', 'location': 'http://[::1]:1900/oqryp/rootDesc.xml', '_timestamp': datetime.datetime(2024, 10, 15, 20, 7, 3, 996795), '_remote_addr': ('fe80::2223:51ff:fe1f:56a4', 59919, 0, 2), '_port': 59919, '_local_addr': ('::', 1900, 0, 0), '_source': <SsdpSource.ADVERTISEMENT: 'advertisement'>}


### Additional information

_No response_
@mobs99
Copy link

mobs99 commented Dec 17, 2024 •
edited
Loading

I seem to have the same issue, started occurring on 2024.12.2 and the mac address is for two hue bulbs that are currently configured and working (direct hue zigbee integration mot through hub)

2024-12-18 05:58:17.812 ERROR (MainThread) [homeassistant.helpers.device_registry] Unexpected exception from <function async_setup_cleanup.<locals>._async_cleanup at 0x7f9ac8daa480> Traceback (most recent call last): File "/usr/src/homeassistant/homeassistant/helpers/debounce.py", line 134, in _handle_timer_finish if task := self.hass.async_run_hass_job( ~~~~~~~~~~~~~~~~~~~~~~~~~~~~^ self._job, background=self._background ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ ): ^ File "/usr/src/homeassistant/homeassistant/core.py", line 949, in async_run_hass_job hassjob.target(*args) ~~~~~~~~~~~~~~^^^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 1415, in _async_cleanup async_cleanup(hass, dev_reg, ent_reg) ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 1384, in async_cleanup dev_reg.async_purge_expired_orphaned_devices() ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^ File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 1254, in async_purge_expired_orphaned_devices del self.deleted_devices[deleted_device.id] ~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/registry.py", line 62, in __delitem__ self._unindex_entry(key) ~~~~~~~~~~~~~~~~~~~^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/device_registry.py", line 558, in _unindex_entry del self._connections[connection] ~~~~~~~~~~~~~~~~~^^^^^^^^^^^^ KeyError: ('mac', '00:17:88:01:xx:xx:xx:xx')

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
@JelmerD @mobs99