jim@home-broker:~ $ fauxmo -vvv
2023-04-06 06:40:12 fauxmo:42 INFO Fauxmo v0.6.0
2023-04-06 06:40:12 fauxmo:43 DEBUG 3.9.2 (default, Feb 28 2021, 17:03:44)
[GCC 10.2.1 20210110]
2023-04-06 06:40:12 fauxmo:51 INFO Using config: /etc/fauxmo/config.json
2023-04-06 06:40:12 fauxmo:26 DEBUG Attempting to get IP address automatically
2023-04-06 06:40:12 fauxmo:41 DEBUG Using IP address: 192.168.0.173
2023-04-06 06:40:12 fauxmo:112 DEBUG plugin_vars: {}
2023-04-06 06:40:12 fauxmo:118 DEBUG device config: {'port': 56880, 'name': 'foo', 'on_cmd': ['button', 'on'], 'off_cmd': ['button', 'off'], 'state_cmd': 'button', 'mqtt_server': '192.168.0.173', 'mqtt_port': 1883}
2023-04-06 06:40:12 asyncio:1521 INFO <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> is serving
2023-04-06 06:40:12 fauxmo:133 DEBUG Started fauxmo device: {'name': 'foo', 'plugin': MQTTPlugin(on_cmd='button', on_value='on', off_cmd='button', off_value='off', state_cmd='button', status='unknown', _subscribed=True, client=<paho.mqtt.client.Client object at 0xffff8cc6f1c0>, _name='foo', _port=56880, _latest_action='off')}
2023-04-06 06:40:12 fauxmo:135 INFO Starting UDP server
2023-04-06 06:40:12 asyncio:1375 DEBUG Datagram endpoint remote_addr=None created: (<_SelectorDatagramTransport fd=11 read=idle write=<idle, bufsize=0>>, <fauxmo.protocols.SSDPServer object at 0xffff8d56a940>)
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.8', 48334):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
MAN: "ssdp:discover"
MX: 5
ST: upnp:rootdevice
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.8', 48334) with mx 5.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 7399b663-0224-416c-a152-fc1415f081db\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.43', 50000):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.43', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 4466e99b-246d-4bd7-a4ca-0bfdeb01a4bc\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.43', 50000):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.43', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 82610684-abf3-4bd9-9b54-edba5c80c2b4\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.105', 50000):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.105', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 4a0020dd-6dcf-40e7-84ab-65b8ee1ea43a\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.105', 50000):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.105', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: a17ccd4f-11c6-407d-8fbd-320ba122cc47\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.101', 50000):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.101', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: fc09bdf0-7825-4348-a179-d314d62df6b0\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.101', 50000):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.101', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 2ce9cc09-d3e2-48b4-bd2b-9957414da15f\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.127', 50000):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.127', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 55b68b3c-ab09-4215-8d09-c3e3a9a50835\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.127', 50000):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.127', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 5f9352c7-da52-42ac-b589-fa8be0e358b6\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.102', 50000):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.102', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1368d23c-24f6-4fdf-8922-cb8cd115d4b5\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.102', 50000):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.102', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: d54eb964-3efd-4c4a-b9a6-cb6d517eb6ab\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:32 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.102', 54290): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.102', 54290)>
2023-04-06 06:40:32 fauxmo:43 DEBUG Connection made with: ('192.168.0.102', 54290)
2023-04-06 06:40:32 fauxmo:55 DEBUG Received message:
GET /setup.xml HTTP/1.1
Host: 192.168.0.173:56880
Accept: */*
Content-Type: application/json
2023-04-06 06:40:32 fauxmo:57 INFO setup.xml requested by Echo
2023-04-06 06:40:32 fauxmo:103 DEBUG Fauxmo response to setup request:
HTTP/1.1 200 OK
CONTENT-LENGTH: 943
CONTENT-TYPE: text/xml
DATE: Thu, 06 Apr 2023 05:40:32 GMT
LAST-MODIFIED: Sat, 01 Jan 2000 00:01:15 GMT
SERVER: Unspecified, UPnP/1.0, Unspecified
X-User-Agent: Fauxmo
CONNECTION: close
<?xml version="1.0"?><root><specVersion><major>1</major><minor>0</minor></specVersion><device><deviceType>urn:Belkin:device:controllee:1</deviceType><friendlyName>foo</friendlyName><manufacturer>Belkin International Inc.</manufacturer><modelName>Emulated Socket</modelName><modelNumber>3.1415</modelNumber><UDN>uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f</UDN><serviceList><service><serviceType>urn:Belkin:service:basicevent:1</serviceType><serviceId>urn:Belkin:serviceId:basicevent1</serviceId><controlURL>/upnp/control/basicevent1</controlURL><eventSubURL>/upnp/event/basicevent1</eventSubURL><SCPDURL>/eventservice.xml</SCPDURL></service><service><serviceType>urn:Belkin:service:metainfo:1</serviceType><serviceId>urn:Belkin:serviceId:metainfo1</serviceId><controlURL>/upnp/control/metainfo1</controlURL><eventSubURL>/upnp/event/metainfo1</eventSubURL><SCPDURL>/metainfoservice.xml</SCPDURL></service></serviceList></device></root>
2023-04-06 06:40:32 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.102', 54291): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.102', 54291)>
2023-04-06 06:40:32 fauxmo:43 DEBUG Connection made with: ('192.168.0.102', 54291)
2023-04-06 06:40:32 fauxmo:55 DEBUG Received message:
POST /upnp/control/basicevent1 HTTP/1.1
Host: 192.168.0.173:56880
Content-Type: text/xml; charset="utf-8"
SOAPACTION: "urn:Belkin:service:basicevent:1#GetBinaryState"
Content-Length: 298
<?xml version="1.0" encoding="utf-8"?><s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetBinaryState xmlns:u="urn:Belkin:service:basicevent:1"><BinaryState>1</BinaryState></u:GetBinaryState></s:Body></s:Envelope>
2023-04-06 06:40:32 fauxmo:66 INFO request BasicEvent1
2023-04-06 06:40:32 fauxmo:114 DEBUG Handling action for plugin type MQTTPlugin(on_cmd='button', on_value='on', off_cmd='button', off_value='off', state_cmd='button', status='unknown', _subscribed=True, client=<paho.mqtt.client.Client object at 0xffff8cc6f1c0>, _name='foo', _port=56880, _latest_action='off')
2023-04-06 06:40:32 fauxmo:140 INFO Attempting to get state for foo
2023-04-06 06:40:32 fauxmo:146 INFO foo state: unknown
2023-04-06 06:40:32 fauxmo:188 WARNING Unable to complete command for foo:
POST /upnp/control/basicevent1 HTTP/1.1
Host: 192.168.0.173:56880
Content-Type: text/xml; charset="utf-8"
SOAPACTION: "urn:Belkin:service:basicevent:1#GetBinaryState"
Content-Length: 298
<?xml version="1.0" encoding="utf-8"?><s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetBinaryState xmlns:u="urn:Belkin:service:basicevent:1"><BinaryState>1</BinaryState></u:GetBinaryState></s:Body></s:Envelope>
2023-04-06 06:40:32 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.127', 59742): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.127', 59742)>
2023-04-06 06:40:32 fauxmo:43 DEBUG Connection made with: ('192.168.0.127', 59742)
2023-04-06 06:40:32 fauxmo:55 DEBUG Received message:
GET /setup.xml HTTP/1.1
Host: 192.168.0.173:56880
Accept: */*
Content-Type: application/json
2023-04-06 06:40:32 fauxmo:57 INFO setup.xml requested by Echo
2023-04-06 06:40:32 fauxmo:103 DEBUG Fauxmo response to setup request:
HTTP/1.1 200 OK
CONTENT-LENGTH: 943
CONTENT-TYPE: text/xml
DATE: Thu, 06 Apr 2023 05:40:32 GMT
LAST-MODIFIED: Sat, 01 Jan 2000 00:01:15 GMT
SERVER: Unspecified, UPnP/1.0, Unspecified
X-User-Agent: Fauxmo
CONNECTION: close
<?xml version="1.0"?><root><specVersion><major>1</major><minor>0</minor></specVersion><device><deviceType>urn:Belkin:device:controllee:1</deviceType><friendlyName>foo</friendlyName><manufacturer>Belkin International Inc.</manufacturer><modelName>Emulated Socket</modelName><modelNumber>3.1415</modelNumber><UDN>uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f</UDN><serviceList><service><serviceType>urn:Belkin:service:basicevent:1</serviceType><serviceId>urn:Belkin:serviceId:basicevent1</serviceId><controlURL>/upnp/control/basicevent1</controlURL><eventSubURL>/upnp/event/basicevent1</eventSubURL><SCPDURL>/eventservice.xml</SCPDURL></service><service><serviceType>urn:Belkin:service:metainfo:1</serviceType><serviceId>urn:Belkin:serviceId:metainfo1</serviceId><controlURL>/upnp/control/metainfo1</controlURL><eventSubURL>/upnp/event/metainfo1</eventSubURL><SCPDURL>/metainfoservice.xml</SCPDURL></service></serviceList></device></root>
2023-04-06 06:40:32 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.127', 59744): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.127', 59744)>
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.165', 50000):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:32 fauxmo:43 DEBUG Connection made with: ('192.168.0.127', 59744)
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.165', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 28c6c11e-746f-4e9b-9800-1005638ab45a\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:32 fauxmo:344 DEBUG Received data below from ('192.168.0.165', 50000):
2023-04-06 06:40:32 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:32 fauxmo:420 DEBUG Sending response to ('192.168.0.165', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:32 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 0f09dbe4-7755-4b90-be32-629d7b625f4b\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:32 fauxmo:55 DEBUG Received message:
POST /upnp/control/basicevent1 HTTP/1.1
Host: 192.168.0.173:56880
Content-Type: text/xml; charset="utf-8"
SOAPACTION: "urn:Belkin:service:basicevent:1#GetBinaryState"
Content-Length: 298
<?xml version="1.0" encoding="utf-8"?><s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetBinaryState xmlns:u="urn:Belkin:service:basicevent:1"><BinaryState>1</BinaryState></u:GetBinaryState></s:Body></s:Envelope>
2023-04-06 06:40:32 fauxmo:66 INFO request BasicEvent1
2023-04-06 06:40:32 fauxmo:114 DEBUG Handling action for plugin type MQTTPlugin(on_cmd='button', on_value='on', off_cmd='button', off_value='off', state_cmd='button', status='unknown', _subscribed=True, client=<paho.mqtt.client.Client object at 0xffff8cc6f1c0>, _name='foo', _port=56880, _latest_action='off')
2023-04-06 06:40:32 fauxmo:140 INFO Attempting to get state for foo
2023-04-06 06:40:32 fauxmo:146 INFO foo state: unknown
2023-04-06 06:40:32 fauxmo:188 WARNING Unable to complete command for foo:
POST /upnp/control/basicevent1 HTTP/1.1
Host: 192.168.0.173:56880
Content-Type: text/xml; charset="utf-8"
SOAPACTION: "urn:Belkin:service:basicevent:1#GetBinaryState"
Content-Length: 298
<?xml version="1.0" encoding="utf-8"?><s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetBinaryState xmlns:u="urn:Belkin:service:basicevent:1"><BinaryState>1</BinaryState></u:GetBinaryState></s:Body></s:Envelope>
2023-04-06 06:40:33 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.165', 49863): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.165', 49863)>
2023-04-06 06:40:33 fauxmo:43 DEBUG Connection made with: ('192.168.0.165', 49863)
2023-04-06 06:40:33 fauxmo:55 DEBUG Received message:
GET /setup.xml HTTP/1.1
Host: 192.168.0.173:56880
Accept: */*
Content-Type: application/json
2023-04-06 06:40:33 fauxmo:57 INFO setup.xml requested by Echo
2023-04-06 06:40:33 fauxmo:103 DEBUG Fauxmo response to setup request:
HTTP/1.1 200 OK
CONTENT-LENGTH: 943
CONTENT-TYPE: text/xml
DATE: Thu, 06 Apr 2023 05:40:33 GMT
LAST-MODIFIED: Sat, 01 Jan 2000 00:01:15 GMT
SERVER: Unspecified, UPnP/1.0, Unspecified
X-User-Agent: Fauxmo
CONNECTION: close
<?xml version="1.0"?><root><specVersion><major>1</major><minor>0</minor></specVersion><device><deviceType>urn:Belkin:device:controllee:1</deviceType><friendlyName>foo</friendlyName><manufacturer>Belkin International Inc.</manufacturer><modelName>Emulated Socket</modelName><modelNumber>3.1415</modelNumber><UDN>uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f</UDN><serviceList><service><serviceType>urn:Belkin:service:basicevent:1</serviceType><serviceId>urn:Belkin:serviceId:basicevent1</serviceId><controlURL>/upnp/control/basicevent1</controlURL><eventSubURL>/upnp/event/basicevent1</eventSubURL><SCPDURL>/eventservice.xml</SCPDURL></service><service><serviceType>urn:Belkin:service:metainfo:1</serviceType><serviceId>urn:Belkin:serviceId:metainfo1</serviceId><controlURL>/upnp/control/metainfo1</controlURL><eventSubURL>/upnp/event/metainfo1</eventSubURL><SCPDURL>/metainfoservice.xml</SCPDURL></service></serviceList></device></root>
2023-04-06 06:40:33 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.165', 49865): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.165', 49865)>
2023-04-06 06:40:33 fauxmo:43 DEBUG Connection made with: ('192.168.0.165', 49865)
2023-04-06 06:40:33 fauxmo:55 DEBUG Received message:
POST /upnp/control/basicevent1 HTTP/1.1
Host: 192.168.0.173:56880
Content-Type: text/xml; charset="utf-8"
SOAPACTION: "urn:Belkin:service:basicevent:1#GetBinaryState"
Content-Length: 298
<?xml version="1.0" encoding="utf-8"?><s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetBinaryState xmlns:u="urn:Belkin:service:basicevent:1"><BinaryState>1</BinaryState></u:GetBinaryState></s:Body></s:Envelope>
2023-04-06 06:40:33 fauxmo:66 INFO request BasicEvent1
2023-04-06 06:40:33 fauxmo:114 DEBUG Handling action for plugin type MQTTPlugin(on_cmd='button', on_value='on', off_cmd='button', off_value='off', state_cmd='button', status='unknown', _subscribed=True, client=<paho.mqtt.client.Client object at 0xffff8cc6f1c0>, _name='foo', _port=56880, _latest_action='off')
2023-04-06 06:40:33 fauxmo:140 INFO Attempting to get state for foo
2023-04-06 06:40:33 fauxmo:146 INFO foo state: unknown
2023-04-06 06:40:33 fauxmo:188 WARNING Unable to complete command for foo:
POST /upnp/control/basicevent1 HTTP/1.1
Host: 192.168.0.173:56880
Content-Type: text/xml; charset="utf-8"
SOAPACTION: "urn:Belkin:service:basicevent:1#GetBinaryState"
Content-Length: 298
<?xml version="1.0" encoding="utf-8"?><s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetBinaryState xmlns:u="urn:Belkin:service:basicevent:1"><BinaryState>1</BinaryState></u:GetBinaryState></s:Body></s:Envelope>
2023-04-06 06:40:33 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.43', 34170): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.43', 34170)>
2023-04-06 06:40:33 fauxmo:43 DEBUG Connection made with: ('192.168.0.43', 34170)
2023-04-06 06:40:33 fauxmo:55 DEBUG Received message:
GET /setup.xml HTTP/1.1
Host: 192.168.0.173:56880
Accept: */*
Content-Type: application/json
2023-04-06 06:40:33 fauxmo:57 INFO setup.xml requested by Echo
2023-04-06 06:40:33 fauxmo:103 DEBUG Fauxmo response to setup request:
HTTP/1.1 200 OK
CONTENT-LENGTH: 943
CONTENT-TYPE: text/xml
DATE: Thu, 06 Apr 2023 05:40:33 GMT
LAST-MODIFIED: Sat, 01 Jan 2000 00:01:15 GMT
SERVER: Unspecified, UPnP/1.0, Unspecified
X-User-Agent: Fauxmo
CONNECTION: close
<?xml version="1.0"?><root><specVersion><major>1</major><minor>0</minor></specVersion><device><deviceType>urn:Belkin:device:controllee:1</deviceType><friendlyName>foo</friendlyName><manufacturer>Belkin International Inc.</manufacturer><modelName>Emulated Socket</modelName><modelNumber>3.1415</modelNumber><UDN>uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f</UDN><serviceList><service><serviceType>urn:Belkin:service:basicevent:1</serviceType><serviceId>urn:Belkin:serviceId:basicevent1</serviceId><controlURL>/upnp/control/basicevent1</controlURL><eventSubURL>/upnp/event/basicevent1</eventSubURL><SCPDURL>/eventservice.xml</SCPDURL></service><service><serviceType>urn:Belkin:service:metainfo:1</serviceType><serviceId>urn:Belkin:serviceId:metainfo1</serviceId><controlURL>/upnp/control/metainfo1</controlURL><eventSubURL>/upnp/event/metainfo1</eventSubURL><SCPDURL>/metainfoservice.xml</SCPDURL></service></serviceList></device></root>
2023-04-06 06:40:33 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.43', 34173): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.43', 34173)>
2023-04-06 06:40:33 fauxmo:43 DEBUG Connection made with: ('192.168.0.43', 34173)
2023-04-06 06:40:33 fauxmo:55 DEBUG Received message:
POST /upnp/control/basicevent1 HTTP/1.1
Host: 192.168.0.173:56880
Content-Type: text/xml; charset="utf-8"
SOAPACTION: "urn:Belkin:service:basicevent:1#GetBinaryState"
Content-Length: 298
<?xml version="1.0" encoding="utf-8"?><s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetBinaryState xmlns:u="urn:Belkin:service:basicevent:1"><BinaryState>1</BinaryState></u:GetBinaryState></s:Body></s:Envelope>
2023-04-06 06:40:33 fauxmo:66 INFO request BasicEvent1
2023-04-06 06:40:33 fauxmo:114 DEBUG Handling action for plugin type MQTTPlugin(on_cmd='button', on_value='on', off_cmd='button', off_value='off', state_cmd='button', status='unknown', _subscribed=True, client=<paho.mqtt.client.Client object at 0xffff8cc6f1c0>, _name='foo', _port=56880, _latest_action='off')
2023-04-06 06:40:33 fauxmo:140 INFO Attempting to get state for foo
2023-04-06 06:40:33 fauxmo:146 INFO foo state: unknown
2023-04-06 06:40:33 fauxmo:188 WARNING Unable to complete command for foo:
POST /upnp/control/basicevent1 HTTP/1.1
Host: 192.168.0.173:56880
Content-Type: text/xml; charset="utf-8"
SOAPACTION: "urn:Belkin:service:basicevent:1#GetBinaryState"
Content-Length: 298
<?xml version="1.0" encoding="utf-8"?><s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetBinaryState xmlns:u="urn:Belkin:service:basicevent:1"><BinaryState>1</BinaryState></u:GetBinaryState></s:Body></s:Envelope>
2023-04-06 06:40:34 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.8', 32915): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.8', 32915)>
2023-04-06 06:40:34 fauxmo:43 DEBUG Connection made with: ('192.168.0.8', 32915)
2023-04-06 06:40:34 fauxmo:55 DEBUG Received message:
GET /setup.xml HTTP/1.1
Accept: */*
Host: 192.168.0.173:56880
Connection: close
2023-04-06 06:40:34 fauxmo:57 INFO setup.xml requested by Echo
2023-04-06 06:40:34 fauxmo:103 DEBUG Fauxmo response to setup request:
HTTP/1.1 200 OK
CONTENT-LENGTH: 943
CONTENT-TYPE: text/xml
DATE: Thu, 06 Apr 2023 05:40:34 GMT
LAST-MODIFIED: Sat, 01 Jan 2000 00:01:15 GMT
SERVER: Unspecified, UPnP/1.0, Unspecified
X-User-Agent: Fauxmo
CONNECTION: close
<?xml version="1.0"?><root><specVersion><major>1</major><minor>0</minor></specVersion><device><deviceType>urn:Belkin:device:controllee:1</deviceType><friendlyName>foo</friendlyName><manufacturer>Belkin International Inc.</manufacturer><modelName>Emulated Socket</modelName><modelNumber>3.1415</modelNumber><UDN>uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f</UDN><serviceList><service><serviceType>urn:Belkin:service:basicevent:1</serviceType><serviceId>urn:Belkin:serviceId:basicevent1</serviceId><controlURL>/upnp/control/basicevent1</controlURL><eventSubURL>/upnp/event/basicevent1</eventSubURL><SCPDURL>/eventservice.xml</SCPDURL></service><service><serviceType>urn:Belkin:service:metainfo:1</serviceType><serviceId>urn:Belkin:serviceId:metainfo1</serviceId><controlURL>/upnp/control/metainfo1</controlURL><eventSubURL>/upnp/event/metainfo1</eventSubURL><SCPDURL>/metainfoservice.xml</SCPDURL></service></serviceList></device></root>
2023-04-06 06:40:34 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.101', 47774): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.101', 47774)>
2023-04-06 06:40:34 fauxmo:43 DEBUG Connection made with: ('192.168.0.101', 47774)
2023-04-06 06:40:34 fauxmo:55 DEBUG Received message:
GET /setup.xml HTTP/1.1
Host: 192.168.0.173:56880
Accept: */*
Content-Type: application/json
2023-04-06 06:40:34 fauxmo:57 INFO setup.xml requested by Echo
2023-04-06 06:40:34 fauxmo:103 DEBUG Fauxmo response to setup request:
HTTP/1.1 200 OK
CONTENT-LENGTH: 943
CONTENT-TYPE: text/xml
DATE: Thu, 06 Apr 2023 05:40:34 GMT
LAST-MODIFIED: Sat, 01 Jan 2000 00:01:15 GMT
SERVER: Unspecified, UPnP/1.0, Unspecified
X-User-Agent: Fauxmo
CONNECTION: close
<?xml version="1.0"?><root><specVersion><major>1</major><minor>0</minor></specVersion><device><deviceType>urn:Belkin:device:controllee:1</deviceType><friendlyName>foo</friendlyName><manufacturer>Belkin International Inc.</manufacturer><modelName>Emulated Socket</modelName><modelNumber>3.1415</modelNumber><UDN>uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f</UDN><serviceList><service><serviceType>urn:Belkin:service:basicevent:1</serviceType><serviceId>urn:Belkin:serviceId:basicevent1</serviceId><controlURL>/upnp/control/basicevent1</controlURL><eventSubURL>/upnp/event/basicevent1</eventSubURL><SCPDURL>/eventservice.xml</SCPDURL></service><service><serviceType>urn:Belkin:service:metainfo:1</serviceType><serviceId>urn:Belkin:serviceId:metainfo1</serviceId><controlURL>/upnp/control/metainfo1</controlURL><eventSubURL>/upnp/event/metainfo1</eventSubURL><SCPDURL>/metainfoservice.xml</SCPDURL></service></serviceList></device></root>
2023-04-06 06:40:34 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.101', 47775): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.101', 47775)>
2023-04-06 06:40:34 fauxmo:43 DEBUG Connection made with: ('192.168.0.101', 47775)
2023-04-06 06:40:34 fauxmo:55 DEBUG Received message:
POST /upnp/control/basicevent1 HTTP/1.1
Host: 192.168.0.173:56880
Content-Type: text/xml; charset="utf-8"
SOAPACTION: "urn:Belkin:service:basicevent:1#GetBinaryState"
Content-Length: 298
<?xml version="1.0" encoding="utf-8"?><s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetBinaryState xmlns:u="urn:Belkin:service:basicevent:1"><BinaryState>1</BinaryState></u:GetBinaryState></s:Body></s:Envelope>
2023-04-06 06:40:34 fauxmo:66 INFO request BasicEvent1
2023-04-06 06:40:34 fauxmo:114 DEBUG Handling action for plugin type MQTTPlugin(on_cmd='button', on_value='on', off_cmd='button', off_value='off', state_cmd='button', status='unknown', _subscribed=True, client=<paho.mqtt.client.Client object at 0xffff8cc6f1c0>, _name='foo', _port=56880, _latest_action='off')
2023-04-06 06:40:34 fauxmo:140 INFO Attempting to get state for foo
2023-04-06 06:40:34 fauxmo:146 INFO foo state: unknown
2023-04-06 06:40:34 fauxmo:188 WARNING Unable to complete command for foo:
POST /upnp/control/basicevent1 HTTP/1.1
Host: 192.168.0.173:56880
Content-Type: text/xml; charset="utf-8"
SOAPACTION: "urn:Belkin:service:basicevent:1#GetBinaryState"
Content-Length: 298
<?xml version="1.0" encoding="utf-8"?><s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetBinaryState xmlns:u="urn:Belkin:service:basicevent:1"><BinaryState>1</BinaryState></u:GetBinaryState></s:Body></s:Envelope>
2023-04-06 06:40:35 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.105', 52025): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.105', 52025)>
2023-04-06 06:40:35 fauxmo:43 DEBUG Connection made with: ('192.168.0.105', 52025)
2023-04-06 06:40:35 fauxmo:55 DEBUG Received message:
GET /setup.xml HTTP/1.1
Host: 192.168.0.173:56880
Accept: */*
Content-Type: application/json
2023-04-06 06:40:35 fauxmo:57 INFO setup.xml requested by Echo
2023-04-06 06:40:35 fauxmo:103 DEBUG Fauxmo response to setup request:
HTTP/1.1 200 OK
CONTENT-LENGTH: 943
CONTENT-TYPE: text/xml
DATE: Thu, 06 Apr 2023 05:40:35 GMT
LAST-MODIFIED: Sat, 01 Jan 2000 00:01:15 GMT
SERVER: Unspecified, UPnP/1.0, Unspecified
X-User-Agent: Fauxmo
CONNECTION: close
<?xml version="1.0"?><root><specVersion><major>1</major><minor>0</minor></specVersion><device><deviceType>urn:Belkin:device:controllee:1</deviceType><friendlyName>foo</friendlyName><manufacturer>Belkin International Inc.</manufacturer><modelName>Emulated Socket</modelName><modelNumber>3.1415</modelNumber><UDN>uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f</UDN><serviceList><service><serviceType>urn:Belkin:service:basicevent:1</serviceType><serviceId>urn:Belkin:serviceId:basicevent1</serviceId><controlURL>/upnp/control/basicevent1</controlURL><eventSubURL>/upnp/event/basicevent1</eventSubURL><SCPDURL>/eventservice.xml</SCPDURL></service><service><serviceType>urn:Belkin:service:metainfo:1</serviceType><serviceId>urn:Belkin:serviceId:metainfo1</serviceId><controlURL>/upnp/control/metainfo1</controlURL><eventSubURL>/upnp/event/metainfo1</eventSubURL><SCPDURL>/metainfoservice.xml</SCPDURL></service></serviceList></device></root>
2023-04-06 06:40:35 asyncio:166 DEBUG <Server sockets=(<asyncio.TransportSocket fd=8, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880)>,)> got a new connection from ('192.168.0.105', 52026): <socket.socket fd=12, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=6, laddr=('192.168.0.173', 56880), raddr=('192.168.0.105', 52026)>
2023-04-06 06:40:35 fauxmo:43 DEBUG Connection made with: ('192.168.0.105', 52026)
2023-04-06 06:40:35 fauxmo:55 DEBUG Received message:
POST /upnp/control/basicevent1 HTTP/1.1
Host: 192.168.0.173:56880
Content-Type: text/xml; charset="utf-8"
SOAPACTION: "urn:Belkin:service:basicevent:1#GetBinaryState"
Content-Length: 298
<?xml version="1.0" encoding="utf-8"?><s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetBinaryState xmlns:u="urn:Belkin:service:basicevent:1"><BinaryState>1</BinaryState></u:GetBinaryState></s:Body></s:Envelope>
2023-04-06 06:40:35 fauxmo:66 INFO request BasicEvent1
2023-04-06 06:40:35 fauxmo:114 DEBUG Handling action for plugin type MQTTPlugin(on_cmd='button', on_value='on', off_cmd='button', off_value='off', state_cmd='button', status='unknown', _subscribed=True, client=<paho.mqtt.client.Client object at 0xffff8cc6f1c0>, _name='foo', _port=56880, _latest_action='off')
2023-04-06 06:40:35 fauxmo:140 INFO Attempting to get state for foo
2023-04-06 06:40:35 fauxmo:146 INFO foo state: unknown
2023-04-06 06:40:35 fauxmo:188 WARNING Unable to complete command for foo:
POST /upnp/control/basicevent1 HTTP/1.1
Host: 192.168.0.173:56880
Content-Type: text/xml; charset="utf-8"
SOAPACTION: "urn:Belkin:service:basicevent:1#GetBinaryState"
Content-Length: 298
<?xml version="1.0" encoding="utf-8"?><s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetBinaryState xmlns:u="urn:Belkin:service:basicevent:1"><BinaryState>1</BinaryState></u:GetBinaryState></s:Body></s:Envelope>
2023-04-06 06:40:35 fauxmo:344 DEBUG Received data below from ('192.168.0.43', 50000):
2023-04-06 06:40:35 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:35 fauxmo:420 DEBUG Sending response to ('192.168.0.43', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:35 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: cd19444f-0f37-4829-b8e7-9fe7b510e369\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:35 fauxmo:344 DEBUG Received data below from ('192.168.0.43', 50000):
2023-04-06 06:40:35 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:35 fauxmo:420 DEBUG Sending response to ('192.168.0.43', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:35 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: e002f2da-2e56-415b-8929-6d83d9e4a2f5\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:35 fauxmo:344 DEBUG Received data below from ('192.168.0.102', 50000):
2023-04-06 06:40:35 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:35 fauxmo:420 DEBUG Sending response to ('192.168.0.102', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:35 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: b94e2616-7ab7-4b73-b3f1-9df51c7190be\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:35 fauxmo:344 DEBUG Received data below from ('192.168.0.102', 50000):
2023-04-06 06:40:35 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:35 fauxmo:420 DEBUG Sending response to ('192.168.0.102', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:35 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 2f476710-76d9-4f2b-9e39-a025dce03ecf\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:35 fauxmo:344 DEBUG Received data below from ('192.168.0.101', 50000):
2023-04-06 06:40:35 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:35 fauxmo:420 DEBUG Sending response to ('192.168.0.101', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:35 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 5e60445b-7da6-447e-8dae-ef8f71d89cc6\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:35 fauxmo:344 DEBUG Received data below from ('192.168.0.101', 50000):
2023-04-06 06:40:35 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:35 fauxmo:420 DEBUG Sending response to ('192.168.0.101', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:35 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: b89480ed-5930-4c4d-a2ac-fedda676fdb5\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:35 fauxmo:344 DEBUG Received data below from ('192.168.0.127', 50000):
2023-04-06 06:40:35 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:35 fauxmo:420 DEBUG Sending response to ('192.168.0.127', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:35 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: e037a10f-1fb6-4a81-a1f8-150a11c984fe\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:35 fauxmo:344 DEBUG Received data below from ('192.168.0.127', 50000):
2023-04-06 06:40:35 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:35 fauxmo:420 DEBUG Sending response to ('192.168.0.127', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:35 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 363f84a6-b323-424d-a907-7b601dc4356f\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:35 fauxmo:344 DEBUG Received data below from ('192.168.0.105', 50000):
2023-04-06 06:40:35 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:35 fauxmo:420 DEBUG Sending response to ('192.168.0.105', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:35 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: f6397619-5e7c-4f88-a6b6-e2c148e89eb1\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:35 fauxmo:344 DEBUG Received data below from ('192.168.0.105', 50000):
2023-04-06 06:40:35 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:35 fauxmo:420 DEBUG Sending response to ('192.168.0.105', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:35 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 1a0ec6f9-d37d-4252-a942-37a523c15da0\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:35 fauxmo:344 DEBUG Received data below from ('192.168.0.165', 50000):
2023-04-06 06:40:35 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:35 fauxmo:420 DEBUG Sending response to ('192.168.0.165', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:35 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: cbdfe0ef-9a63-4d68-aa12-b179e7dc1d0a\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:35 fauxmo:344 DEBUG Received data below from ('192.168.0.165', 50000):
2023-04-06 06:40:35 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:35 fauxmo:420 DEBUG Sending response to ('192.168.0.165', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:35 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 6aeacc4d-0533-4bdc-8065-8c009ff3f9af\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:38 fauxmo:344 DEBUG Received data below from ('192.168.0.43', 50000):
2023-04-06 06:40:38 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:38 fauxmo:420 DEBUG Sending response to ('192.168.0.43', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:38 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 3e4186e7-e9f0-43eb-a751-70c2eebecb13\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:38 fauxmo:344 DEBUG Received data below from ('192.168.0.43', 50000):
2023-04-06 06:40:38 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:38 fauxmo:420 DEBUG Sending response to ('192.168.0.43', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:38 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 95a20d1b-94c1-477f-9bb1-c78a53820bb6\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:38 fauxmo:344 DEBUG Received data below from ('192.168.0.102', 50000):
2023-04-06 06:40:38 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:38 fauxmo:420 DEBUG Sending response to ('192.168.0.102', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:38 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: d2506f49-6860-4ac5-89ea-a1bfb506c1c1\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:38 fauxmo:344 DEBUG Received data below from ('192.168.0.102', 50000):
2023-04-06 06:40:38 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:38 fauxmo:420 DEBUG Sending response to ('192.168.0.102', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:38 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 7eb8b337-835e-45d2-ac49-724713debd8e\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:38 fauxmo:344 DEBUG Received data below from ('192.168.0.101', 50000):
2023-04-06 06:40:38 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:38 fauxmo:420 DEBUG Sending response to ('192.168.0.101', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:38 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 0731570c-8eb8-4a1d-b940-c0c492aa2de6\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:38 fauxmo:344 DEBUG Received data below from ('192.168.0.101', 50000):
2023-04-06 06:40:38 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:38 fauxmo:420 DEBUG Sending response to ('192.168.0.101', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:38 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 8685c802-3151-4ce4-892b-6f23e5247b7a\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:38 fauxmo:344 DEBUG Received data below from ('192.168.0.105', 50000):
2023-04-06 06:40:38 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:38 fauxmo:420 DEBUG Sending response to ('192.168.0.105', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:38 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 786bd388-8f07-4d48-98e6-3db2bd71145d\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:38 fauxmo:344 DEBUG Received data below from ('192.168.0.105', 50000):
2023-04-06 06:40:38 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:38 fauxmo:420 DEBUG Sending response to ('192.168.0.105', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:38 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: fcf0aaa1-7e53-4a55-8297-c0bf9e2ebf91\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:38 fauxmo:344 DEBUG Received data below from ('192.168.0.127', 50000):
2023-04-06 06:40:38 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:38 fauxmo:420 DEBUG Sending response to ('192.168.0.127', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:38 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: ca4be3d0-789c-4aa1-8987-97b7d8e50a9e\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:38 fauxmo:344 DEBUG Received data below from ('192.168.0.127', 50000):
2023-04-06 06:40:38 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:38 fauxmo:420 DEBUG Sending response to ('192.168.0.127', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:38 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: ee6defbc-034b-4e17-8d87-2171b3e40114\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'
2023-04-06 06:40:38 fauxmo:344 DEBUG Received data below from ('192.168.0.165', 50000):
2023-04-06 06:40:38 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: ssdp:all
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:38 fauxmo:420 DEBUG Sending response to ('192.168.0.165', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:38 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 271e11c5-7e27-4bb4-ae46-d43a0ca39cdc\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: ssdp:all\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::ssdp:all\r\n\r\n'
2023-04-06 06:40:38 fauxmo:344 DEBUG Received data below from ('192.168.0.165', 50000):
2023-04-06 06:40:38 fauxmo:345 DEBUG M-SEARCH * HTTP/1.1
HOST: 239.255.255.250:1900
ST: upnp:rootdevice
MAN: "ssdp:discover"
MX: 3
2023-04-06 06:40:38 fauxmo:420 DEBUG Sending response to ('192.168.0.165', 50000) with mx 3.0:
b'HTTP/1.1 200 OK\r\nCACHE-CONTROL: max-age=86400\r\nDATE: Thu, 06 Apr 2023 05:40:38 GMT\r\nEXT:\r\nLOCATION: http://192.168.0.173:56880/setup.xml\r\nOPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01\r\n01-NLS: 72df45fd-2b72-4061-ba15-d5c72d371ccf\r\nSERVER: Fauxmo, UPnP/1.0, Unspecified\r\nST: upnp:rootdevice\r\nUSN: uuid:Socket-1_0-c3c8dbcd-8f60-3825-b42b-162fc311726f::upnp:rootdevice\r\n\r\n'