Apollon77 / hap-controller-node

Node.js library to implement a HAP (HomeKit) controller
Mozilla Public License 2.0
54 stars 16 forks source link

Tado getAccessories problem #61

Closed NebzHB closed 2 years ago

NebzHB commented 2 years ago

Hi,

i have a problem with the Tado thermostat.

when i pair, it's ok, i receive the longPairing datas, but once i try to getAccessories nothing happens (i've learned since my last issue, i've used your example with a but more infos) :

here is my script :

const {HttpClient, IPDiscovery} = require('hap-controller');

var pairingData={
    AccessoryPairingID: '37aaaa7373a39643a62663a66393a6262',
    AccessoryLTPK: '2d1559baaaa8d496630a67640b01e9d9c502cd730420ed48cdbb1f6a7676c',
    iOSDevicePairingID: '333261366aaaad373834362d343162332d383639612d333839333835356536316630',
    iOSDeviceLTSK: '452201c408a41faa94296035aaaacea0f91d64b3e5b92e9b20edf6c0e00d21c90622b0cfee8a324eb1001d2e74342ec15563cd2e71adf8cb2ecac1a45427c',
    iOSDeviceLTPK: '1c90622b0cfaaaaaa342ec15563cd2e71adf8cb2ecac1a45427c'
};

const discovery = new IPDiscovery();

discovery.on('serviceUp', (service) => {
  if(service.address == "192.168.1.73") {
    console.log('Found device! ',service.id,service.address);

    const client = new HttpClient(service.id, service.address, service.port, pairingData);

    client
        .getAccessories()
        .then((acc) => {
            console.log("accessory:",acc);
        })
        .catch((e) => console.error("error:",e));
  }
});
discovery.start();

and the result is :

node --trace-warnings hk.js
Found device!  7a:77:9d:aa:f9:bb 192.168.1.73

and that's all... no "accessory" no "error", just nothing happens... any other way to enable full debug than --trace-warnings ?

Apollon77 commented 2 years ago

Please run with debug

DEBUG=hap-controller* node hk.js

And post output

NebzHB commented 2 years ago

Nothing strange there...

Found device!  7a:77:9d:bf:f9:bb 192.168.1.73
  hap-controller:http-client Start Pair-Verify process ... +0ms
  hap-controller:tlv Add 1 bytes for tag 6: 01 +0ms
  hap-controller:tlv Add 32 bytes for tag 3: 68763105485ad9a05229a8d98c2e7f12e18c20b711b376a395e90920a8a04032 +1ms
  hap-controller:http-connection 192.168.1.73:80 POST /pair-verify 060101032068763105485ad9a05229a8d98c2e7f12e18c20b711b376a395e90920a8a04032 +0ms
  hap-controller:http-connection 192.168.1.73:80 Response 200 with 140 byte data +75ms
  hap-controller:tlv Read 1 bytes for tag 6: 02 +76ms
  hap-controller:tlv Read 32 bytes for tag 3: 099bfcf7af70544d0ca1ba815295ccf6421dbae4ef786963f70b53bb03392230 +0ms
  hap-controller:tlv Read 101 bytes for tag 5: cdacf99f85eb7aad9a9f7c6f646459b6779c8e729b82435a90e5f3a530c4f0c58052ef043b9ed95753cee79950dbb2ff1c9b8b0e1aa3e51d31eee5816fb92dc20c0a49bfe1480aa26899c49811fc347e058beeeeb0896a7203460b9e8528797fee304a1709 +1ms
  hap-controller:tlv Read 17 bytes for tag 1: 37613a37373a39643a62663a66393a6262 +7ms
  hap-controller:tlv Read 64 bytes for tag 10: 48d87c3c68526b339f371b143ae7ef8f8799417a20f9c7911c036fea469f392cecc6265e60f159b2f68fc3d76bb83890b422d4537c3769890b23ae43358bfa09 +1ms
  hap-controller:tlv Add 36 bytes for tag 1: 33326136663131382d373834362d343162332d383639612d333839333835356536316630 +2ms
  hap-controller:tlv Add 64 bytes for tag 10: d637ff129e51b323dafbc37b462d1f9ce9355f3b0d063d5b2fa90a25dafc42e6ffbcd6d0cf7b00e5486118d6b47907b01c16c2b3b251795ea58c71d2b4cf3309 +0ms
  hap-controller:tlv Add 1 bytes for tag 6: 03 +1ms
  hap-controller:tlv Add 120 bytes for tag 5: 6b9f20fa91c1ed1958e3ff5c58dd7d3940bbddaed2d42970fb53e3d570afc2d752983615e2a1bf174494d7dc7b448b0a18f0ad72718e68fbe99940a9ffad22edb32942953849ba4c1d02766b5b8bda4c653786d9c7c184cd862729a52583ccd6efef93dbc9144c3331a877357039d10007a0218f18c2f8ee +0ms
  hap-controller:http-connection 192.168.1.73:80 POST /pair-verify 06010305786b9f20fa91c1ed1958e3ff5c58dd7d3940bbddaed2d42970fb53e3d570afc2d752983615e2a1bf174494d7dc7b448b0a18f0ad72718e68fbe99940a9ffad22edb32942953849ba4c1d02766b5b8bda4c653786d9c7c184cd862729a52583ccd6efef93dbc9144c3331a877357039d10007a0218f18c2f8ee +13ms
  hap-controller:http-connection 192.168.1.73:80 Response 200 with 3 byte data +89ms
  hap-controller:tlv Read 1 bytes for tag 6: 04 +90ms
  hap-controller:http-client Finished Pair-Verify process ... +184ms
  hap-controller:http-connection 192.168.1.73:80 GET /accessories +5ms
Apollon77 commented 2 years ago

I could add some more debug log into the library to better see whats the reason but to me it seems that somehow the device closes the connection "silently" or such and that we do not have a catch for that case ... so it does not throw an error ... If you are willing to test and I could do some changes and you check again ... I can not repro it with my devices here

NebzHB commented 2 years ago

no prob, i've seen alot of devices working fine with this lib, this is the only one i've seen that behaviour

Apollon77 commented 2 years ago

I will leave open here and poke you once I added some debug. I also noticed that the communication functions are not really handling disconnects right now and do not throw an error ... I will change that

NebzHB commented 2 years ago

perfect, if you are interested with the compatibility list I have made until now, here it is : https://nebzhb.github.io/jeedom_docs/plugins/hkControl/fr_FR/#tocAnchor-1-7 (in french)

NebzHB commented 2 years ago

Hi, do you think #79 queuing could solve that getAccessories issue too ?

Apollon77 commented 2 years ago

I fear not because in the logs above there is nothing visible about "Overlapping" pair verifies, biut sure we can try :-)) (but I would wonder if it helps) ... I still have no idea why Tado here is not answering

NebzHB commented 2 years ago

yes in the "pair verify" but could a queue in get accessories could be implemented too ? maybe the same type of issue (not exactly the same), but once again, i don't know the protocol and/or recommandations

Apollon77 commented 2 years ago

There is only one call to getAccessories and not parallel ones, so not relevant ...

Apollon77 commented 2 years ago

BTW @NebzHB try it again ... maybe new version has an efffect and it was a "not cleaned upconnection" causing the issue

Apollon77 commented 2 years ago

@NebzHB Any chance here with new version?

NebzHB commented 2 years ago

I'll push the release on my plugin and ask my tado user to test it again

Apollon77 commented 2 years ago

(but honestly I do not really expect it to work) ... ut maybe we are lucky.

But a new "full debug level log" would be helpful in any case

NebzHB commented 2 years ago
[21-01-2022 17:07:56][INFO] : Pairing demand...
2022-01-21T16:07:56.600Z hap-controller:tlv Add 1 bytes for tag 6: 01
2022-01-21T16:07:56.600Z hap-controller:tlv Add 1 bytes for tag 0: 01
2022-01-21T16:07:56.600Z hap-controller:http-connection 192.168.1.73:80 POST /pair-setup 060101000101
2022-01-21T16:07:58.760Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 409 byte data
2022-01-21T16:07:58.761Z hap-controller:tlv Read 1 bytes for tag 6: 02
2022-01-21T16:07:58.761Z hap-controller:tlv Read 255 bytes for tag 3: f4009f80dfbbdb698b7c0f51e0dfc5f36ee87ebea6cfd6e12cc820d9060164aa9bb6e0f5f145c446fc9e8fa07b55d9fa6c450466b39f6679acd21efc8bd6b02305b52ac54e58a03866e2e4e60ffc503021f56b2e661e135fad3205817d2a504182800bb24cae6f6262a1c4758b23478e2dd560451a5715ab1bf20c24eb24320df0995f645f76ca8e221d3784ebaaaca17526e6e7c3997a76352413f617de974d5a78144777491e027f846b34793ce2c2c19ee80fe498d56746d4041da78696723203bafcb326fc73a1edbf56eb4cd97c9cb6d50ecd2b201e47645baca6f3297189f38391a2025d52d32d3961ceae44eef9236f9fc601bb4e47c04df85193c9
2022-01-21T16:07:58.762Z hap-controller:tlv Read 129 bytes for tag 3: 8d75cef01945d8ff4a2ad0241bf55547c4ffdb1f0d169fd1d2716e4e6cc53b42b22c02cf6f3e16ebe3073a162e57274812d46bfbac4559f11804b61f7b83c1a84f8e9ff904a0b7698d8bdedf1a27484b0ea22e9cfd8fa4ab4ad17738b240d491f8a611194b8249f3a7c057e5a5dc5dc86b4b08c502805cca0de24cfa6ed09d07d3
2022-01-21T16:07:58.762Z hap-controller:tlv Read 16 bytes for tag 2: 00b54297815dd89de919816bf66f8fc0
2022-01-21T16:07:59.323Z hap-controller:tlv Add 1 bytes for tag 6: 03
2022-01-21T16:07:59.323Z hap-controller:tlv Add 255 bytes for tag 3: 52edc19db5b6010ac99a2dfc03e8dc947eb2a9a9ba175fc750a3c437df794ec2a408d4ce52115e351de26c1d60c2d783b820ab88a6cd6f4aca618d0f42fd066bc2b2ec06b7d37380b80dba0548147714e77e3d6e43ebbcb4de58396db998292be4db669e8f2cc3fb5b77d4db81091e709959a01d43fcb955c1e029531b0ca32047fbd24120b45b9553657188e7fb23068ef268a138440d744ccf346c7b9eea75486cf5a904115597589f26a312713b9d553f4cac9ef87b05b8b683925362ff67336455b5b67f5c4e50195e996718db1b41b7d39cad919d17215c755d455f8368e5aa39624420a0050e74f58499716cb9b4ea3a3bb4e602c48acaea89ff80a1
2022-01-21T16:07:59.323Z hap-controller:tlv Add 129 bytes for tag 3: b1a71fe0e8194bb5c5b86827d934b21ffc936f1e3d217b54d13e1679456e36f55a96f4e596e55857ad32e83ee1a1f49637f010f9251b04e2418009e1d92829ba191a94475d512e1efc7c469fc820bbd77d237451de398eb56f5803788816f5b11c62aee6f8ec32fdfdba77956d04ccc299bd2cda526c16492a09d5b114a4b0b112
2022-01-21T16:07:59.323Z hap-controller:tlv Add 64 bytes for tag 4: 6bda3735d640421a8242647d61cf7c02f920831cd855d714cf3920221c9758deb14b9740019bff43b1f4dd7eaee46903661d79e4b066e764cd1bd8c562e7ff78
2022-01-21T16:07:59.323Z hap-controller:http-connection 192.168.1.73:80 POST /pair-setup 06010303ff52edc19db5b6010ac99a2dfc03e8dc947eb2a9a9ba175fc750a3c437df794ec2a408d4ce52115e351de26c1d60c2d783b820ab88a6cd6f4aca618d0f42fd066bc2b2ec06b7d37380b80dba0548147714e77e3d6e43ebbcb4de58396db998292be4db669e8f2cc3fb5b77d4db81091e709959a01d43fcb955c1e029531b0ca32047fbd24120b45b9553657188e7fb23068ef268a138440d744ccf346c7b9eea75486cf5a904115597589f26a312713b9d553f4cac9ef87b05b8b683925362ff67336455b5b67f5c4e50195e996718db1b41b7d39cad919d17215c755d455f8368e5aa39624420a0050e74f58499716cb9b4ea3a3bb4e602c48acaea89ff80a10381b1a71fe0e8194bb5c5b86827d934b21ffc936f1e3d217b54d13e1679456e36f55a96f4e596e55857ad32e83ee1a1f49637f010f9251b04e2418009e1d92829ba191a94475d512e1efc7c469fc820bbd77d237451de398eb56f5803788816f5b11c62aee6f8ec32fdfdba77956d04ccc299bd2cda526c16492a09d5b114a4b0b11204406bda3735d640421a8242647d61cf7c02f920831cd855d714cf3920221c9758deb14b9740019bff43b1f4dd7eaee46903661d79e4b066e764cd1bd8c562e7ff78
2022-01-21T16:08:04.227Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 1141 byte data
2022-01-21T16:08:04.228Z hap-controller:tlv Read 1 bytes for tag 6: 04
2022-01-21T16:08:04.229Z hap-controller:tlv Read 64 bytes for tag 4: 45e8cb3c204f0f216be51cec0c5573319790687887870b9bc415a5d07f263db11b9a33af6ec890cb021d00c3cc2404343aa86fdfc467dfad9a9232d1bd877507
2022-01-21T16:08:04.229Z hap-controller:tlv Read 255 bytes for tag 5: a4b38333c0fde2ea49d50dc23ffca13c3db9cfcda86bb60cd7741bca78c4cbf8e3a096788d353c1b625dc5d0b86bc9d2f634cd0aaaf3b688b10c14433815c1a3eb9efbf091cd2deeef2e7cb5fa8af1c885d78523023e1b02d05cb348f79eb8430bbacdc6e12f1693ed4a8ee13399d8e7c34d07541da0c21bcefb2fca3eca94eeef3a95dc14a65ded8e0a952355662f88eda30a7048c6468a517fcbcaff6f9448cc15c19c40e242d2d87f11e8cc5dec37217f49ce032573249c1344a9a52939f7a23a351279f8864d86401aba525754834b12c544fcb4b029722c5c9e0089c143426027aefff03044f0435a22fe39ac67cf7518721288ccf789b136f275a99e
2022-01-21T16:08:04.229Z hap-controller:tlv Read 255 bytes for tag 5: aefbe932348544af4f72572c8065b38c7adeb6c7773c19828998ea20246f3a60fa4d76aa2f9372f1ef92b60e172f60f4be169969a4bdf33ed11483dc1dbc5c1b821cd4fd4925bae36665db56f276e43598d9ac06ff85069dc8be1d68bb8d88f34fee38b414bb7e1ed9a8e314ba6a6f62888034dcba9e07b2d55584b402793695b2ce9e94403229b16569a80467be3caa494842d0b095bdc83dd994cfc6c387da58bc4d967aad9fe04b1c89879548ea95ed5fc8ccaab749290a961f50919b6b7fe2cba18265c0187850f0164d7a8693d2495df9a612d3bb625bc4445ad7d7d70033c9c99533aa27e4e548d4d1b1f599184056215e978544b8a06e0e4ed51929
2022-01-21T16:08:04.229Z hap-controller:tlv Read 255 bytes for tag 5: 45fbd570a4092bbe55cc4518dd67fd896f91d188460a06f28270e04c525960b3665f34f9f49f783fc0fe2e595ce5ba80d4e394990765ec27fab0c5f1f784d314458efe24842b72de508be724acd31ce309699bae2422e74465bda2bbc838c85d98cddcedc00d9bd4431e930fa6a739506db146651c6c9b7d0975ee20423dafdc1c3ae56a86729105baf0b4aebdf20de224537283d3fb166e37d5b0393bfa8fb7a80b8b651f6d60d339ccb1fde69c3ecda015e058f63474b9a2410c8410e3dbdb8e3ee42dadb1ece5e28b553be43f1d47199aa20d7043bedbabbd4e34ea79d8d6e509c0b34b6c28f365925c20e6001af281794d26f1c432f1212a7d9fea2318
2022-01-21T16:08:04.229Z hap-controller:tlv Read 255 bytes for tag 5: a8b7ce598e445a557bc519be2a9660722df995cc54f71654debf3eca90b069aff855725f94069781d35495b756ada2d796104051343a52fb04dea5196a9990973f769282852eff6860518952dd096f591b44487bb2bc7c489b31fb5e954e57ac196048bc50d2068ebb2cc2fa9223c19fe21e1020068b412a7ec21419f7ad2a4c7da90d8ea5a35d28390c32fd1aa444ad27a3d8909fae395c5d9f915ef376e6a6a2ecf9f14389304cf321ab6b48effd87153d9b18360821302d133e60e4dd0a943f97895d24ca6950dd2d4a212482644cb6f108fb43ef69402acbf61b5d4b8750dda0ae0b460c95d06c05ee23c8b827fd1a813df95dcf521c0996c156e6a04a
2022-01-21T16:08:04.229Z hap-controller:tlv Read 42 bytes for tag 5: 9c669a52015c3509c9699a217d647c74d6149fb577ca14cef872da20b16af699a4ca7f15288e8ffa179a
2022-01-21T16:08:04.236Z hap-controller:tlv Add 36 bytes for tag 1: 65323238376465362d636461302d346639312d396235392d323835386331373534333438
2022-01-21T16:08:04.237Z hap-controller:tlv Add 32 bytes for tag 3: 096bfffef98094a6b28d12f3bf09b601dc90c5a62d20ecba99de000a6434f5d7
2022-01-21T16:08:04.237Z hap-controller:tlv Add 64 bytes for tag 10: 0a1a9185903e18db40289d6d75aeb266b16b03265faf70c72a17326ed9958f2d542772befa2a784744767721d05b1d634cea58b82997095dd4b19916c665f203
2022-01-21T16:08:04.238Z hap-controller:tlv Add 1 bytes for tag 6: 05
2022-01-21T16:08:04.238Z hap-controller:tlv Add 154 bytes for tag 5: 302b28062e04ed53a06b3ebbf5b7b8c51b58c3a609a79c5340dba30bcc04b6b360c73859b4c0a32091ed109c49a49598486b1d11ef1e8324a3f746009370df621b01dd7eab53277ae28202209cde5b8a72a12a663ae3b2296a8e7ddfdf36f867c6d04792113f828200a7f6d25a41150520c0f55fe8495372434eba98794b8f76bb362e962e130b66fd3ce5dacc53b6b16088fc6c72b7997649fa
2022-01-21T16:08:04.238Z hap-controller:http-connection 192.168.1.73:80 POST /pair-setup 060105059a302b28062e04ed53a06b3ebbf5b7b8c51b58c3a609a79c5340dba30bcc04b6b360c73859b4c0a32091ed109c49a49598486b1d11ef1e8324a3f746009370df621b01dd7eab53277ae28202209cde5b8a72a12a663ae3b2296a8e7ddfdf36f867c6d04792113f828200a7f6d25a41150520c0f55fe8495372434eba98794b8f76bb362e962e130b66fd3ce5dacc53b6b16088fc6c72b7997649fa
2022-01-21T16:08:04.657Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 140 byte data
2022-01-21T16:08:04.658Z hap-controller:tlv Read 1 bytes for tag 6: 06
2022-01-21T16:08:04.659Z hap-controller:tlv Read 135 bytes for tag 5: 3d07add10131d2655f9cc8442fb2c6d762aeb951e620af05049ee8ffb4abd5f0eeb8071ea8ef42a078e6abf0842dc7bfe794b08613ea92b36b7b0e6c746c01cfe4752fd38671815470b49e000dcee05c235a4be7a5cd54f1c34de8e3df443bd159681a819afb58e858e8c239cb1556d271f3437e79f2eea03051bf7c870e95e37e2f9665a91fe9
2022-01-21T16:08:04.659Z hap-controller:tlv Read 17 bytes for tag 1: 62353a39303a36393a32633a39623a3331
2022-01-21T16:08:04.659Z hap-controller:tlv Read 32 bytes for tag 3: 9af4917e07f427239a4729eb8f59d34cf0f7987a96507e273074d0cdf02cfe58
2022-01-21T16:08:04.659Z hap-controller:tlv Read 64 bytes for tag 10: 2725a1efa1930c544aa629d8b2c6670e6cb2c4439d68982ba9cacae057d8356f422f168cbb2565200a62a4287810c9521517744835c186ab783d328e56ddd70f
[21-01-2022 17:08:04][INFO] : Pairing succes of  tado Internet Bridge IB3005030144(b5:90:69:2c:9b:31)
[21-01-2022 17:08:04][DEBUG] : get Accessories
2022-01-21T16:08:04.667Z hap-controller:http-client Start Pair-Verify process ...
2022-01-21T16:08:04.669Z hap-controller:tlv Add 1 bytes for tag 6: 01
2022-01-21T16:08:04.669Z hap-controller:tlv Add 32 bytes for tag 3: b882ca22de06205348b551665140c81a5603ffb5be24f8e9f47731d7ed893167
2022-01-21T16:08:04.669Z hap-controller:http-connection 192.168.1.73:80 POST /pair-verify 0601010320b882ca22de06205348b551665140c81a5603ffb5be24f8e9f47731d7ed893167
2022-01-21T16:08:04.759Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 140 byte data
2022-01-21T16:08:04.759Z hap-controller:tlv Read 1 bytes for tag 6: 02
2022-01-21T16:08:04.759Z hap-controller:tlv Read 32 bytes for tag 3: f087b454432d9264d5cd0ccc01535732628e700f254734231638fb987eb1d317
2022-01-21T16:08:04.760Z hap-controller:tlv Read 101 bytes for tag 5: 426e5faee3bd2a3a3e36b802cebe658294ad389239192b58bdde1b2362525c7a1f7b4480887eb15c5b53e1d93d1893646ba14b64d3680196fc7d4385904d9cf103d08f937539093e59e6dd3f0cf0e8c88791ea10d60b446e5187045ac50917e7bf885f8aa5
2022-01-21T16:08:04.762Z hap-controller:tlv Read 17 bytes for tag 1: 62353a39303a36393a32633a39623a3331
2022-01-21T16:08:04.762Z hap-controller:tlv Read 64 bytes for tag 10: cf97f8ad32dc3a664b9fca475a57b61ea014bc71ae8dee9b70857cf3232045592c2cd6f5f9f09b66760f5fb31507074bc1c87f094d414d68f9b0734077801805
2022-01-21T16:08:04.764Z hap-controller:tlv Add 36 bytes for tag 1: 65323238376465362d636461302d346639312d396235392d323835386331373534333438
2022-01-21T16:08:04.764Z hap-controller:tlv Add 64 bytes for tag 10: 559d977b3373a923e385ce70384afc107a1c3075ce923438bdd0896a944ad0964680d9e75ca9aca275f958fa1187b3d95d1f3ebe3607d6cc424e5551e10eb701
2022-01-21T16:08:04.764Z hap-controller:tlv Add 1 bytes for tag 6: 03
2022-01-21T16:08:04.765Z hap-controller:tlv Add 120 bytes for tag 5: 2bc6d1adbdbfb81265329cb0d70fee9ef7330c1ec2c6486e63a337943bd80ff567dadfc143aa40176c2822af8167f60add1f02aba4210174a8950123946620bd4625a36c42c6b72b4dc5c19ac57e4413537f7ee39ca311d214ba8da943841ee530147609a30d49d91373f3e4c18a927029fbb905911fe614
2022-01-21T16:08:04.765Z hap-controller:http-connection 192.168.1.73:80 POST /pair-verify 06010305782bc6d1adbdbfb81265329cb0d70fee9ef7330c1ec2c6486e63a337943bd80ff567dadfc143aa40176c2822af8167f60add1f02aba4210174a8950123946620bd4625a36c42c6b72b4dc5c19ac57e4413537f7ee39ca311d214ba8da943841ee530147609a30d49d91373f3e4c18a927029fbb905911fe614
2022-01-21T16:08:04.852Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 3 byte data
2022-01-21T16:08:04.853Z hap-controller:tlv Read 1 bytes for tag 6: 04
2022-01-21T16:08:04.853Z hap-controller:http-client Finished Pair-Verify process ...
2022-01-21T16:08:04.854Z hap-controller:http-client New new connection client initialized
2022-01-21T16:08:04.854Z hap-controller:http-connection 192.168.1.73:80 GET /accessories

sadly, same :(

Apollon77 commented 2 years ago

:-( One last idea ... can you add a delay between a pairing success and the first getAccessories ... like 1-2s or such (just as a try) ... and see if it changes anything?

NebzHB commented 2 years ago

there is already 8sec, but i'll try to add few sec

edit : oh ok you say that because of this : image

Apollon77 commented 2 years ago

WHere are here 8s? ;-)) 16:08:04 vs 16:08:04 :-) Between pair finish and next pairVerify I see <10ms :-)

NebzHB commented 2 years ago

does it need 8s ? or does the protocol says we need to wait 8s ?

i've pushed it to 2s now, i'm waiting for my user's feedback

Apollon77 commented 2 years ago

No, protocol says nothing and in all my rtries with devices I have access too it was never an issue to contact the device immediately ... The delay was just an idea that "it maybe was too fast for this device". But with 8s we are already "way too delayed" ... so no idea :-(

Apollon77 commented 2 years ago

Interesting question last but not least is: Does pairing works with Apple Home App?

NebzHB commented 2 years ago

Yes it's working (i got confirmation from my user)

Apollon77 commented 2 years ago

So Apple Home app works (And really via Home App and not Tado app is used? ;-)))) ), the library not ... then honestly ... no further idea :-(

NebzHB commented 2 years ago

yes no tado app... can't put more logs to see why it's blocking ? or timeout to at-least gain the process back (blocking) (i've tried with Promise.raceAll agains a setTimeout but not very proper...)

Apollon77 commented 2 years ago

Yes adding timeouts is a feature request in #80 ... but this can not be the solution :-( (ok yes it will "Help" somehow-ish but I still do not get whats wrong)

NebzHB commented 2 years ago

yes it's just a workaround to not having my daemon to hang...

nobody with tado in ioBroker ?

Apollon77 commented 2 years ago

Noone that reported such an issue so far

stale[bot] commented 2 years ago

This issue has been automatically marked as stale because it has not had recent activity. It will be closed if no further activity occurs within the next 7 days. Please check if the issue is still relevant in the most current version of the adapter and tell us. Also check that all relevant details, logs and reproduction steps are included and update them if needed. Thank you for your contributions. Dieses Problem wurde automatisch als veraltet markiert, da es in letzter Zeit keine Aktivitäten gab. Es wird geschlossen, wenn nicht innerhalb der nächsten 7 Tage weitere Aktivitäten stattfinden. Bitte überprüft, ob das Problem auch in der aktuellsten Version des Adapters noch relevant ist, und teilt uns dies mit. Überprüft auch, ob alle relevanten Details, Logs und Reproduktionsschritte enthalten sind bzw. aktualisiert diese. Vielen Dank für Eure Unterstützung.

NebzHB commented 2 years ago

keep it plz

Apollon77 commented 2 years ago

I most likely found the issue ... maybe ... The library till now did not sent an "Host" header in the HTTP calls ... but we found out that some devices seems to require it. Lets see later with new version if this also helps here

Apollon77 commented 2 years ago

@NebzHB wanne try GitHub version of the lib? :-)

NebzHB commented 2 years ago

I deployed the 0.7.4 in my plugin in "beta" and i've asked one of my user to test it, i'll let you know

NebzHB commented 2 years ago

Hello, First feedback from users, this version seems to solve Tado issues (and solves Somfy Tahoma V2 too !!).

I close the issue and will re-open if anything else come out...

Thank you for your researchs !

NebzHB commented 2 years ago

Sorry... my user get alot of event-disconnect on that (it's ethernet, no wifi) and with setCharacteristics, there is alot of timeout too... (i've set a timeout on my side with Promise.race to 10 sec...)

i ask for logs and keep u updated

Apollon77 commented 2 years ago

Any channce to get a fgull debug log (so started with DEBUG=... like described in readme?

NebzHB commented 2 years ago

i ask for logs and keep u updated

yes yes coming asap

NebzHB commented 2 years ago

here is the normal subscription to the events :

[09-05-2022 15:52:48][DEBUG] : Subscription in progress to tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
2022-05-09T13:52:48.321Z hap-controller:http-client Start Pair-Verify process ...
2022-05-09T13:52:48.322Z hap-controller:tlv Add 1 bytes for tag 6: 01
2022-05-09T13:52:48.322Z hap-controller:tlv Add 32 bytes for tag 3: 82970483a4269243b23b18b64e66732f9bc3fba3c8f761af44af814468a2403a
2022-05-09T13:52:48.322Z hap-controller:http-connection 192.168.1.73:80 POST /pair-verify 060101032082970483a4269243b23b18b64e66732f9bc3fba3c8f761af44af814468a2403a (application/pairing+tlv8)
2022-05-09T13:52:48.383Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 140 byte data
2022-05-09T13:52:48.384Z hap-controller:tlv Read 1 bytes for tag 6: 02
2022-05-09T13:52:48.384Z hap-controller:tlv Read 32 bytes for tag 3: 7a2d22e0e49d5cff3f96a37f182678a8a572157a6291b537cd127e7263796712
2022-05-09T13:52:48.384Z hap-controller:tlv Read 101 bytes for tag 5: 770a564cb7c6afc0b1cba6760503ca6a433bd7cf6468de90dc138f5805ad76d94804c56328ba810eb8d3d362e73391959ff3b7cef8c359d0cc5cf83e715ac59251eb5c7e8834cad08ba2eeea4a9a0dd8241bb984066f1e7df901280960d7b1e3a6dfdc95b9
2022-05-09T13:52:48.385Z hap-controller:tlv Read 17 bytes for tag 1: 31623a64633a38613a36313a65373a3134
2022-05-09T13:52:48.385Z hap-controller:tlv Read 64 bytes for tag 10: 7de94c9e36d6b5a899d75960e07e988e1c38cd4de51b117f5d5fa83f503ae06907ed0555ff3961a2bf4db9c1328e54dc3d04f3f43bdc53b3c0b92d72d394830d
2022-05-09T13:52:48.386Z hap-controller:tlv Add 36 bytes for tag 1: 61313466666331622d346361342d346166352d396334662d383361363931643265333666
2022-05-09T13:52:48.386Z hap-controller:tlv Add 64 bytes for tag 10: ce12ce5b5554f2983a57e079367b74d6730ca22c1f3e643554f9d79775979542785136a8890ccac2aebba11a966f461a54e46e9d4c8ff4223dda2ebf3c996e03
2022-05-09T13:52:48.386Z hap-controller:tlv Add 1 bytes for tag 6: 03
2022-05-09T13:52:48.386Z hap-controller:tlv Add 120 bytes for tag 5: a0af2afd43eb4cfda281a7925da8e2d9d3d279db3f303c684f1b4ed5e76df1f584f865e6ab4264bdaae745d884a4425127c955d61215c76e68375c838f97f7f1dd4b0f490b45093a40d07eb86aa72ae197e39399bb25c74c288466d7e3c173feae02567991ad08f8c5c0fabfaf0971660bbc3bbe0d508df8
2022-05-09T13:52:48.386Z hap-controller:http-connection 192.168.1.73:80 POST /pair-verify 0601030578a0af2afd43eb4cfda281a7925da8e2d9d3d279db3f303c684f1b4ed5e76df1f584f865e6ab4264bdaae745d884a4425127c955d61215c76e68375c838f97f7f1dd4b0f490b45093a40d07eb86aa72ae197e39399bb25c74c288466d7e3c173feae02567991ad08f8c5c0fabfaf0971660bbc3bbe0d508df8 (application/pairing+tlv8)
2022-05-09T13:52:48.477Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 3 byte data
2022-05-09T13:52:48.477Z hap-controller:tlv Read 1 bytes for tag 6: 04
2022-05-09T13:52:48.478Z hap-controller:http-client Finished Pair-Verify process ...
2022-05-09T13:52:48.479Z hap-controller:http-connection 192.168.1.73:80 PUT /characteristics 7b22636861726163746572697374696373223a5b7b22616964223a322c22696964223a31322c226576223a747275657d2c7b22616964223a322c22696964223a31332c226576223a747275657d2c7b22616964223a322c22696964223a31342c226576223a747275657d2c7b22616964223a322c22696964223a31352c226576223a747275657d2c7b22616964223a322c22696964223a31362c226576223a747275657d2c7b22616964223a322c22696964223a31372c226576223a747275657d2c7b22616964223a332c22696964223a31322c226576223a747275657d2c7b22616964223a332c22696964223a31332c226576223a747275657d2c7b22616964223a332c22696964223a31342c226576223a747275657d2c7b22616964223a332c22696964223a31352c226576223a747275657d2c7b22616964223a332c22696964223a31362c226576223a747275657d2c7b22616964223a332c22696964223a31372c226576223a747275657d2c7b22616964223a342c22696964223a31322c226576223a747275657d2c7b22616964223a342c22696964223a31332c226576223a747275657d2c7b22616964223a342c22696964223a31342c226576223a747275657d2c7b22616964223a342c22696964223a31352c226576223a747275657d2c7b22616964223a342c22696964223a31362c226576223a747275657d2c7b22616964223a342c22696964223a31372c226576223a747275657d2c7b22616964223a352c22696964223a31322c226576223a747275657d2c7b22616964223a352c22696964223a31332c226576223a747275657d2c7b22616964223a352c22696964223a31342c226576223a747275657d2c7b22616964223a352c22696964223a31352c226576223a747275657d2c7b22616964223a352c22696964223a31362c226576223a747275657d2c7b22616964223a352c22696964223a31372c226576223a747275657d5d7d
2022-05-09T13:52:48.507Z hap-controller:http-connection 192.168.1.73:80 Response 204 with 0 byte data
[09-05-2022 15:52:48][DEBUG] : Subscribed to tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17 !

then here is a "event-disconnect" :

2022-05-09T13:55:07.407Z hap-controller:http-client Persistent connection client got disconnected
[09-05-2022 15:55:29][DEBUG] : Event-disconnect received from tado Internet Bridge IB3005030144 : 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 15:55:29][DEBUG] : Resubscribe in progress for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
2022-05-09T13:55:29.935Z hap-controller:http-client Start Pair-Verify process ...
2022-05-09T13:55:29.937Z hap-controller:tlv Add 1 bytes for tag 6: 01
2022-05-09T13:55:29.937Z hap-controller:tlv Add 32 bytes for tag 3: 9ccb1dab732621483f210ca16219989cee87065cadb225ea2977853aaea1b631
2022-05-09T13:55:29.937Z hap-controller:http-connection 192.168.1.73:80 POST /pair-verify 06010103209ccb1dab732621483f210ca16219989cee87065cadb225ea2977853aaea1b631 (application/pairing+tlv8)
2022-05-09T13:55:30.007Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 140 byte data
2022-05-09T13:55:30.008Z hap-controller:tlv Read 1 bytes for tag 6: 02
2022-05-09T13:55:30.008Z hap-controller:tlv Read 32 bytes for tag 3: aa1941c6c2131ce31eba1e09f1c1bbfc34b1789dafa5d550180e7c70bff21e50
2022-05-09T13:55:30.008Z hap-controller:tlv Read 101 bytes for tag 5: 6879005e8c32b172d82275ae3f1ee0a611b529460f272234fe7063aaafa7dcb0db4da00d10761142193e2f9b10d076355b753acdac11ed95f7a6ab77c121f22ed49576d072bc13f46bda0549eec5be8bbc8f17ff46ef77c85dd141fcafa0939bf9db50fb79
2022-05-09T13:55:30.010Z hap-controller:tlv Read 17 bytes for tag 1: 31623a64633a38613a36313a65373a3134
2022-05-09T13:55:30.011Z hap-controller:tlv Read 64 bytes for tag 10: a2e961e4d895ac6ef0d18572e7bee1611fd1aa1105885dc6e467cec86a824d73185dfaf881adeeb8caae4502a01578ccfe72c8ac624af1e77a63738851a1c807
2022-05-09T13:55:30.012Z hap-controller:tlv Add 36 bytes for tag 1: 61313466666331622d346361342d346166352d396334662d383361363931643265333666
2022-05-09T13:55:30.012Z hap-controller:tlv Add 64 bytes for tag 10: 3ad76e266cc23ffc8af052038790dbc5bf1507643ce3618d102641f3a1e1c435755e618664f317eef4fbb243f2b3225d0e0b9c1e227005871abdb4a944b4a505
2022-05-09T13:55:30.013Z hap-controller:tlv Add 1 bytes for tag 6: 03
2022-05-09T13:55:30.013Z hap-controller:tlv Add 120 bytes for tag 5: bfc536af8bd5fa5fb4dca87defaae0d35cdc9c6fdf0c6095f6594606f70ccd10b91a6efd61fb3106e7c299883b5208e1b2d029542e760d0c7cda159d989da882d09c5bc9e278d422ac7cd81a59ba2f42010527befc91f24a1ee075ecb0f5ddbcbe6010dea19e59e32e4a5416a08ae3bd907646c1e7d52f99
2022-05-09T13:55:30.013Z hap-controller:http-connection 192.168.1.73:80 POST /pair-verify 0601030578bfc536af8bd5fa5fb4dca87defaae0d35cdc9c6fdf0c6095f6594606f70ccd10b91a6efd61fb3106e7c299883b5208e1b2d029542e760d0c7cda159d989da882d09c5bc9e278d422ac7cd81a59ba2f42010527befc91f24a1ee075ecb0f5ddbcbe6010dea19e59e32e4a5416a08ae3bd907646c1e7d52f99 (application/pairing+tlv8)
2022-05-09T13:55:30.100Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 3 byte data
2022-05-09T13:55:30.101Z hap-controller:tlv Read 1 bytes for tag 6: 04
2022-05-09T13:55:30.101Z hap-controller:http-client Finished Pair-Verify process ...
2022-05-09T13:55:30.103Z hap-controller:http-connection 192.168.1.73:80 PUT /characteristics 7b22636861726163746572697374696373223a5b7b22616964223a322c22696964223a31322c226576223a747275657d2c7b22616964223a322c22696964223a31332c226576223a747275657d2c7b22616964223a322c22696964223a31342c226576223a747275657d2c7b22616964223a322c22696964223a31352c226576223a747275657d2c7b22616964223a322c22696964223a31362c226576223a747275657d2c7b22616964223a322c22696964223a31372c226576223a747275657d2c7b22616964223a332c22696964223a31322c226576223a747275657d2c7b22616964223a332c22696964223a31332c226576223a747275657d2c7b22616964223a332c22696964223a31342c226576223a747275657d2c7b22616964223a332c22696964223a31352c226576223a747275657d2c7b22616964223a332c22696964223a31362c226576223a747275657d2c7b22616964223a332c22696964223a31372c226576223a747275657d2c7b22616964223a342c22696964223a31322c226576223a747275657d2c7b22616964223a342c22696964223a31332c226576223a747275657d2c7b22616964223a342c22696964223a31342c226576223a747275657d2c7b22616964223a342c22696964223a31352c226576223a747275657d2c7b22616964223a342c22696964223a31362c226576223a747275657d2c7b22616964223a342c22696964223a31372c226576223a747275657d2c7b22616964223a352c22696964223a31322c226576223a747275657d2c7b22616964223a352c22696964223a31332c226576223a747275657d2c7b22616964223a352c22696964223a31342c226576223a747275657d2c7b22616964223a352c22696964223a31352c226576223a747275657d2c7b22616964223a352c22696964223a31362c226576223a747275657d2c7b22616964223a352c22696964223a31372c226576223a747275657d5d7d
2022-05-09T13:55:30.131Z hap-controller:http-connection 192.168.1.73:80 Response 204 with 0 byte data
[09-05-2022 15:55:30][DEBUG] : Resubscribed correctly to tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17

and here is a setCharacteristic :

[09-05-2022 15:55:38][INFO] : Set Characteristic received...{"id":"1b:dc:8a:61:e7:14","aid":"5","iid":"15","val":"15"}
2022-05-09T13:55:38.077Z hap-controller:http-client Reuse persistent connection client
2022-05-09T13:55:38.078Z hap-controller:http-connection 192.168.1.73:80 PUT /characteristics 7b22636861726163746572697374696373223a5b7b22616964223a352c22696964223a31352c2276616c7565223a31357d5d7d
[09-05-2022 15:55:48][WARNING] : Set characteristic for tado Internet Bridge IB3005030144 has timed out (the device didn't replied in 10sec) TimeOut
[09-05-2022 15:56:13][INFO] : Set Characteristic received...{"id":"1b:dc:8a:61:e7:14","aid":"5","iid":"13","val":"0"}
2022-05-09T13:56:13.043Z hap-controller:http-client Reuse persistent connection client
2022-05-09T13:56:13.044Z hap-controller:http-connection 192.168.1.73:80 PUT /characteristics 7b22636861726163746572697374696373223a5b7b22616964223a352c22696964223a31332c2276616c7565223a307d5d7d
[09-05-2022 15:56:23][WARNING] : Set characteristic for tado Internet Bridge IB3005030144 has timed out (the device didn't replied in 10sec) TimeOut
[09-05-2022 15:56:41][DEBUG] : Event-disconnect received from tado Internet Bridge IB3005030144 : 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 15:56:41][DEBUG] : Resubscribe in progress to tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
2022-05-09T13:56:41.615Z hap-controller:http-client Start Pair-Verify process ...
2022-05-09T13:56:41.617Z hap-controller:tlv Add 1 bytes for tag 6: 01
2022-05-09T13:56:41.617Z hap-controller:tlv Add 32 bytes for tag 3: 075f0bdb62ca4a1fe7a1ac3fec5efb5f189810a391fefd93a7baf2e048e6447a
2022-05-09T13:56:41.617Z hap-controller:http-connection 192.168.1.73:80 POST /pair-verify 0601010320075f0bdb62ca4a1fe7a1ac3fec5efb5f189810a391fefd93a7baf2e048e6447a (application/pairing+tlv8)
2022-05-09T13:56:41.702Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 140 byte data
2022-05-09T13:56:41.702Z hap-controller:tlv Read 1 bytes for tag 6: 02
2022-05-09T13:56:41.702Z hap-controller:tlv Read 32 bytes for tag 3: 815d6f97aa30eda6aa01a7577d700934ed606e14efd6d2e77ba48de569da4c12
2022-05-09T13:56:41.703Z hap-controller:tlv Read 101 bytes for tag 5: 7597f17f64d4bde75752d75924a7416cd33bb9d4a453c5c39e025735b2e95b18e2aa9c48dfdde5d576aedd3c7e48689946328551c8073de1788a69fef84a2e985ff424682f31a7a4ed67692c14512bcf55471ea5eb3a0f84accd77ef2c80fa8f8f2593a0a5
2022-05-09T13:56:41.705Z hap-controller:tlv Read 17 bytes for tag 1: 31623a64633a38613a36313a65373a3134
2022-05-09T13:56:41.705Z hap-controller:tlv Read 64 bytes for tag 10: 8734514dd8afc42da5dd2ca061cd25caf5cf24e0d671b0fe87efba92570d55bcff24d6619faf3c13199049cbc73a09af413278754937cf63b08bb888c99f2002
2022-05-09T13:56:41.707Z hap-controller:tlv Add 36 bytes for tag 1: 61313466666331622d346361342d346166352d396334662d383361363931643265333666
2022-05-09T13:56:41.707Z hap-controller:tlv Add 64 bytes for tag 10: 95a5dc609bc5272c5c2f4efd558185d0d0efc895860b4262cec2999fb0c16f118b25f26dfc088277f427c855d0cbacd7bf62f35d783514c7e1e1713f09e10406
2022-05-09T13:56:41.707Z hap-controller:tlv Add 1 bytes for tag 6: 03
2022-05-09T13:56:41.707Z hap-controller:tlv Add 120 bytes for tag 5: 8e50cbc0d86ed303bbbb3775ec8fd4cc03e6c5dbc278d7eb822515ee0f669e321f32a136c7078117508c0e5f4a8d7147c637a3557c7d1ed23ad5af562c0a4cf504517a06ca3fef03b1b446eaa3c9f68f9d6150f14ef7d2388d7daf58193967321e95b92098689a644e969558f98d5def43f815a83ab236fd
2022-05-09T13:56:41.708Z hap-controller:http-connection 192.168.1.73:80 POST /pair-verify 06010305788e50cbc0d86ed303bbbb3775ec8fd4cc03e6c5dbc278d7eb822515ee0f669e321f32a136c7078117508c0e5f4a8d7147c637a3557c7d1ed23ad5af562c0a4cf504517a06ca3fef03b1b446eaa3c9f68f9d6150f14ef7d2388d7daf58193967321e95b92098689a644e969558f98d5def43f815a83ab236fd (application/pairing+tlv8)
2022-05-09T13:56:41.795Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 3 byte data
2022-05-09T13:56:41.795Z hap-controller:tlv Read 1 bytes for tag 6: 04
2022-05-09T13:56:41.796Z hap-controller:http-client Finished Pair-Verify process ...
2022-05-09T13:56:41.797Z hap-controller:http-connection 192.168.1.73:80 PUT /characteristics 7b22636861726163746572697374696373223a5b7b22616964223a322c22696964223a31322c226576223a747275657d2c7b22616964223a322c22696964223a31332c226576223a747275657d2c7b22616964223a322c22696964223a31342c226576223a747275657d2c7b22616964223a322c22696964223a31352c226576223a747275657d2c7b22616964223a322c22696964223a31362c226576223a747275657d2c7b22616964223a322c22696964223a31372c226576223a747275657d2c7b22616964223a332c22696964223a31322c226576223a747275657d2c7b22616964223a332c22696964223a31332c226576223a747275657d2c7b22616964223a332c22696964223a31342c226576223a747275657d2c7b22616964223a332c22696964223a31352c226576223a747275657d2c7b22616964223a332c22696964223a31362c226576223a747275657d2c7b22616964223a332c22696964223a31372c226576223a747275657d2c7b22616964223a342c22696964223a31322c226576223a747275657d2c7b22616964223a342c22696964223a31332c226576223a747275657d2c7b22616964223a342c22696964223a31342c226576223a747275657d2c7b22616964223a342c22696964223a31352c226576223a747275657d2c7b22616964223a342c22696964223a31362c226576223a747275657d2c7b22616964223a342c22696964223a31372c226576223a747275657d2c7b22616964223a352c22696964223a31322c226576223a747275657d2c7b22616964223a352c22696964223a31332c226576223a747275657d2c7b22616964223a352c22696964223a31342c226576223a747275657d2c7b22616964223a352c22696964223a31352c226576223a747275657d2c7b22616964223a352c22696964223a31362c226576223a747275657d2c7b22616964223a352c22696964223a31372c226576223a747275657d5d7d
2022-05-09T13:56:41.825Z hap-controller:http-connection 192.168.1.73:80 Response 204 with 0 byte data
[09-05-2022 15:56:41][DEBUG] : Resubscribe correctly to tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17

and something strange about Persistent connection client got disconnected :

[09-05-2022 15:56:43][INFO] : Refresh received...
[09-05-2022 15:56:43][DEBUG] : getAccessory...
2022-05-09T13:56:43.146Z hap-controller:http-client Reuse persistent connection client
2022-05-09T13:56:43.147Z hap-controller:http-connection 192.168.1.73:80 GET /accessories
2022-05-09T13:56:49.806Z hap-controller:http-client Persistent connection client got disconnected
[09-05-2022 15:56:56][INFO] : setCharacteristic received...{"id":"1b:dc:8a:61:e7:14","aid":"5","iid":"13","val":"1"}
2022-05-09T13:56:56.133Z hap-controller:http-client Reuse persistent connection client
2022-05-09T13:56:56.134Z hap-controller:http-connection 192.168.1.73:80 PUT /characteristics 7b22636861726163746572697374696373223a5b7b22616964223a352c22696964223a31332c2276616c7565223a317d5d7d
[09-05-2022 15:57:06][WARNING] : Set characteristic for tado Internet Bridge IB3005030144 has timed out (the device didn't replied in 10sec) TimeOut
[09-05-2022 15:57:53][DEBUG] : Event-disconnect received for tado Internet Bridge IB3005030144 : 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 15:57:53][DEBUG] : Resubscribe in progress to tado Internet Bridge IB3005030144 on2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
2022-05-09T13:57:53.295Z hap-controller:http-client Start Pair-Verify process ...
2022-05-09T13:57:53.296Z hap-controller:tlv Add 1 bytes for tag 6: 01
2022-05-09T13:57:53.296Z hap-controller:tlv Add 32 bytes for tag 3: 31afcb642f301031e1b56794c24325a50685a16b32a3f3c6cdc7bf747232d261
2022-05-09T13:57:53.296Z hap-controller:http-connection 192.168.1.73:80 POST /pair-verify 060101032031afcb642f301031e1b56794c24325a50685a16b32a3f3c6cdc7bf747232d261 (application/pairing+tlv8)
2022-05-09T13:57:53.380Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 140 byte data
2022-05-09T13:57:53.381Z hap-controller:tlv Read 1 bytes for tag 6: 02
2022-05-09T13:57:53.381Z hap-controller:tlv Read 32 bytes for tag 3: 42d36b750aa5420de4d1d38864980ae0e3cb720790ba922023d175f815b9ea6b
2022-05-09T13:57:53.381Z hap-controller:tlv Read 101 bytes for tag 5: 9a22a7e857717a7d0e63a8a6f8d5fa7b87ec45be8ba3ac10a6250ce4ee7b5d49f2dbe2a05f32270097d4268b588abd8ff7ee28c5fd5e2dbdfeb07ad06849b71e41199970730ce66dbd4f5b1c9d3206ca21d3934476a2651bcd4e3ed2759fa3bb449ae171af
2022-05-09T13:57:53.384Z hap-controller:tlv Read 17 bytes for tag 1: 31623a64633a38613a36313a65373a3134
2022-05-09T13:57:53.384Z hap-controller:tlv Read 64 bytes for tag 10: 919b14f0b9acbf0fc592f089aad839fa7026a921364140caa5537546c312f3bc795a5aef9670c3113ff8a6d20b119d95d1c3ff191327b4bef96155b03714010a
2022-05-09T13:57:53.385Z hap-controller:tlv Add 36 bytes for tag 1: 61313466666331622d346361342d346166352d396334662d383361363931643265333666
2022-05-09T13:57:53.386Z hap-controller:tlv Add 64 bytes for tag 10: 73faddafd1872b8ec5da98fb6c443a874a5e67d9d5f14f244424abe993175b14ac908290c4d3215241751bc7349a58a0018b812e6681f9325b30d3ee69cafd03
2022-05-09T13:57:53.386Z hap-controller:tlv Add 1 bytes for tag 6: 03
2022-05-09T13:57:53.386Z hap-controller:tlv Add 120 bytes for tag 5: 35f135dbd9cdab0de83975a3a723eef0e0847a4b733027add770c90666d940863bfdf925422f8cfb3318ba2d033c7501be7a9e43fc5c616e7eff533dd792252c4a614b529b972213f26300ba926b05e12e3a044383956997112b8d40f70d2108ad7ed7a3e8e171588ab2c415feace59c1d0bd677669290db
2022-05-09T13:57:53.386Z hap-controller:http-connection 192.168.1.73:80 POST /pair-verify 060103057835f135dbd9cdab0de83975a3a723eef0e0847a4b733027add770c90666d940863bfdf925422f8cfb3318ba2d033c7501be7a9e43fc5c616e7eff533dd792252c4a614b529b972213f26300ba926b05e12e3a044383956997112b8d40f70d2108ad7ed7a3e8e171588ab2c415feace59c1d0bd677669290db (application/pairing+tlv8)
2022-05-09T13:57:53.474Z hap-controller:http-connection 192.168.1.73:80 Response 200 with 3 byte data
2022-05-09T13:57:53.474Z hap-controller:tlv Read 1 bytes for tag 6: 04
2022-05-09T13:57:53.475Z hap-controller:http-client Finished Pair-Verify process ...
2022-05-09T13:57:53.476Z hap-controller:http-connection 192.168.1.73:80 PUT /characteristics 7b22636861726163746572697374696373223a5b7b22616964223a322c22696964223a31322c226576223a747275657d2c7b22616964223a322c22696964223a31332c226576223a747275657d2c7b22616964223a322c22696964223a31342c226576223a747275657d2c7b22616964223a322c22696964223a31352c226576223a747275657d2c7b22616964223a322c22696964223a31362c226576223a747275657d2c7b22616964223a322c22696964223a31372c226576223a747275657d2c7b22616964223a332c22696964223a31322c226576223a747275657d2c7b22616964223a332c22696964223a31332c226576223a747275657d2c7b22616964223a332c22696964223a31342c226576223a747275657d2c7b22616964223a332c22696964223a31352c226576223a747275657d2c7b22616964223a332c22696964223a31362c226576223a747275657d2c7b22616964223a332c22696964223a31372c226576223a747275657d2c7b22616964223a342c22696964223a31322c226576223a747275657d2c7b22616964223a342c22696964223a31332c226576223a747275657d2c7b22616964223a342c22696964223a31342c226576223a747275657d2c7b22616964223a342c22696964223a31352c226576223a747275657d2c7b22616964223a342c22696964223a31362c226576223a747275657d2c7b22616964223a342c22696964223a31372c226576223a747275657d2c7b22616964223a352c22696964223a31322c226576223a747275657d2c7b22616964223a352c22696964223a31332c226576223a747275657d2c7b22616964223a352c22696964223a31342c226576223a747275657d2c7b22616964223a352c22696964223a31352c226576223a747275657d2c7b22616964223a352c22696964223a31362c226576223a747275657d2c7b22616964223a352c22696964223a31372c226576223a747275657d5d7d
2022-05-09T13:57:53.504Z hap-controller:http-connection 192.168.1.73:80 Response 204 with 0 byte data
[09-05-2022 15:57:53][DEBUG] : Resubscribe correctly to tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
Apollon77 commented 2 years ago

Strange. In fact there are two connections in the lib. One dedicated for the subscrption and a second for all other requests.

The "Persistent connection client got disconnected" is about the "normal" connection. "event-disconnect" is about the subscription one.

So it seems that the tado bridge here and there kills all connections at the same timepoint as your log shows.

For me it seems that set characteristics to {"id":"1b:dc:8a:61:e7:14","aid":"5","iid":"13","val":"0/1"} trigger something. Which state is that?

Apollon77 commented 2 years ago

PS: Could you please post the accessories JSON? That we can see what 5.15 and 5.13 are?

NebzHB commented 2 years ago

it's heating-cooling.target and temperature.target (don't mind the "typeLabel", it's added by me for debug purpose ;) ):

[{
        "aid": 1,
        "services": [{
                "type": "0000003E-0000-1000-8000-0026BB765291",
                "iid": 1,
                "primary": false,
                "hidden": false,
                "characteristics": [{
                        "iid": 2,
                        "type": "00000023-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado Internet Bridge IB3005030144",
                        "format": "string",
                        "typeLabel": "name"
                    }, {
                        "iid": 3,
                        "type": "00000020-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado",
                        "format": "string",
                        "typeLabel": "manufacturer"
                    }, {
                        "iid": 4,
                        "type": "00000030-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "IB3005030144",
                        "format": "string",
                        "typeLabel": "serial-number"
                    }, {
                        "iid": 5,
                        "type": "00000021-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "IB01",
                        "format": "string",
                        "typeLabel": "model"
                    }, {
                        "iid": 6,
                        "type": "00000052-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "92.1",
                        "format": "string",
                        "typeLabel": "firmware.revision"
                    }, {
                        "iid": 7,
                        "type": "00000014-0000-1000-8000-0026BB765291",
                        "perms": ["pw"],
                        "format": "bool",
                        "typeLabel": "identify"
                    }
                ],
                "typeLabel": "accessory-information"
            }, {
                "type": "E44673A0-247B-4360-8A76-DB9DA69C0100",
                "iid": 8,
                "primary": false,
                "hidden": true,
                "characteristics": [{
                        "iid": 9,
                        "type": "E44673A0-247B-4360-8A76-DB9DA69C0101",
                        "perms": ["pw"],
                        "format": "string",
                        "typeLabel": "E44673A0-247B-4360-8A76-DB9DA69C0101"
                    }
                ],
                "typeLabel": "E44673A0-247B-4360-8A76-DB9DA69C0100"
            }
        ]
    }, {
        "aid": 2,
        "services": [{
                "type": "0000003E-0000-1000-8000-0026BB765291",
                "iid": 1,
                "primary": false,
                "hidden": false,
                "characteristics": [{
                        "iid": 2,
                        "type": "00000023-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado Smart Thermostat SU2817924608",
                        "format": "string",
                        "typeLabel": "name"
                    }, {
                        "iid": 3,
                        "type": "00000020-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado",
                        "format": "string",
                        "typeLabel": "manufacturer"
                    }, {
                        "iid": 4,
                        "type": "00000030-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "SU2817924608",
                        "format": "string",
                        "typeLabel": "serial-number"
                    }, {
                        "iid": 5,
                        "type": "00000021-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "ST01",
                        "format": "string",
                        "typeLabel": "model"
                    }, {
                        "iid": 6,
                        "type": "00000052-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "90.1",
                        "format": "string",
                        "typeLabel": "firmware.revision"
                    }, {
                        "iid": 7,
                        "type": "00000014-0000-1000-8000-0026BB765291",
                        "perms": ["pw"],
                        "format": "bool",
                        "typeLabel": "identify"
                    }
                ],
                "typeLabel": "accessory-information"
            }, {
                "type": "E44673A0-247B-4360-8A76-DB9DA69C0100",
                "iid": 8,
                "primary": false,
                "hidden": true,
                "characteristics": [{
                        "iid": 9,
                        "type": "E44673A0-247B-4360-8A76-DB9DA69C0101",
                        "perms": ["pw"],
                        "format": "string",
                        "typeLabel": "E44673A0-247B-4360-8A76-DB9DA69C0101"
                    }
                ],
                "typeLabel": "E44673A0-247B-4360-8A76-DB9DA69C0100"
            }, {
                "type": "0000004A-0000-1000-8000-0026BB765291",
                "iid": 10,
                "primary": true,
                "hidden": false,
                "characteristics": [{
                        "iid": 11,
                        "type": "00000023-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado Smart Thermostat SU2817924608",
                        "format": "string",
                        "typeLabel": "name"
                    }, {
                        "iid": 12,
                        "type": "0000000F-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "ev"],
                        "value": 0,
                        "maxValue": 2,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "uint8",
                        "typeLabel": "heating-cooling.current"
                    }, {
                        "iid": 13,
                        "type": "00000033-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "pw", "ev"],
                        "value": 1,
                        "maxValue": 1,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "uint8",
                        "typeLabel": "heating-cooling.target"
                    }, {
                        "iid": 14,
                        "type": "00000011-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "ev"],
                        "value": 20.8,
                        "maxValue": 100,
                        "minValue": 0,
                        "minStep": 0.1,
                        "format": "float",
                        "unit": "celsius",
                        "typeLabel": "temperature.current"
                    }, {
                        "iid": 15,
                        "type": "00000035-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "pw", "ev"],
                        "value": 17,
                        "maxValue": 25,
                        "minValue": 5,
                        "minStep": 0.1,
                        "format": "float",
                        "unit": "celsius",
                        "typeLabel": "temperature.target"
                    }, {
                        "iid": 16,
                        "type": "00000036-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "pw", "ev"],
                        "value": 0,
                        "maxValue": 1,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "uint8",
                        "typeLabel": "temperature.units"
                    }, {
                        "iid": 17,
                        "type": "00000010-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "ev"],
                        "value": 63,
                        "maxValue": 100,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "float",
                        "unit": "percentage",
                        "typeLabel": "relative-humidity.current"
                    }
                ],
                "typeLabel": "thermostat"
            }
        ]
    }, {
        "aid": 3,
        "services": [{
                "type": "0000003E-0000-1000-8000-0026BB765291",
                "iid": 1,
                "primary": false,
                "hidden": false,
                "characteristics": [{
                        "iid": 2,
                        "type": "00000023-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado Smart Radiator Thermostat VA0494611200",
                        "format": "string",
                        "typeLabel": "name"
                    }, {
                        "iid": 3,
                        "type": "00000020-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado",
                        "format": "string",
                        "typeLabel": "manufacturer"
                    }, {
                        "iid": 4,
                        "type": "00000030-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "VA0494611200",
                        "format": "string",
                        "typeLabel": "serial-number"
                    }, {
                        "iid": 5,
                        "type": "00000021-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "SRT01",
                        "format": "string",
                        "typeLabel": "model"
                    }, {
                        "iid": 6,
                        "type": "00000052-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "95.1",
                        "format": "string",
                        "typeLabel": "firmware.revision"
                    }, {
                        "iid": 7,
                        "type": "00000014-0000-1000-8000-0026BB765291",
                        "perms": ["pw"],
                        "format": "bool",
                        "typeLabel": "identify"
                    }
                ],
                "typeLabel": "accessory-information"
            }, {
                "type": "E44673A0-247B-4360-8A76-DB9DA69C0100",
                "iid": 8,
                "primary": false,
                "hidden": true,
                "characteristics": [{
                        "iid": 9,
                        "type": "E44673A0-247B-4360-8A76-DB9DA69C0101",
                        "perms": ["pw"],
                        "format": "string",
                        "typeLabel": "E44673A0-247B-4360-8A76-DB9DA69C0101"
                    }
                ],
                "typeLabel": "E44673A0-247B-4360-8A76-DB9DA69C0100"
            }, {
                "type": "0000004A-0000-1000-8000-0026BB765291",
                "iid": 10,
                "primary": true,
                "hidden": false,
                "characteristics": [{
                        "iid": 11,
                        "type": "00000023-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado Smart Radiator Thermostat VA0494611200",
                        "format": "string",
                        "typeLabel": "name"
                    }, {
                        "iid": 12,
                        "type": "0000000F-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "ev"],
                        "value": 0,
                        "maxValue": 2,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "uint8",
                        "typeLabel": "heating-cooling.current"
                    }, {
                        "iid": 13,
                        "type": "00000033-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "pw", "ev"],
                        "value": 1,
                        "maxValue": 1,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "uint8",
                        "typeLabel": "heating-cooling.target"
                    }, {
                        "iid": 14,
                        "type": "00000011-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "ev"],
                        "value": 19.4,
                        "maxValue": 100,
                        "minValue": 0,
                        "minStep": 0.1,
                        "format": "float",
                        "unit": "celsius",
                        "typeLabel": "temperature.current"
                    }, {
                        "iid": 15,
                        "type": "00000035-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "pw", "ev"],
                        "value": 17,
                        "maxValue": 25,
                        "minValue": 5,
                        "minStep": 0.1,
                        "format": "float",
                        "unit": "celsius",
                        "typeLabel": "temperature.target"
                    }, {
                        "iid": 16,
                        "type": "00000036-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "pw", "ev"],
                        "value": 0,
                        "maxValue": 1,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "uint8",
                        "typeLabel": "temperature.units"
                    }, {
                        "iid": 17,
                        "type": "00000010-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "ev"],
                        "value": 53,
                        "maxValue": 100,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "float",
                        "unit": "percentage",
                        "typeLabel": "relative-humidity.current"
                    }
                ],
                "typeLabel": "thermostat"
            }
        ]
    }, {
        "aid": 4,
        "services": [{
                "type": "0000003E-0000-1000-8000-0026BB765291",
                "iid": 1,
                "primary": false,
                "hidden": false,
                "characteristics": [{
                        "iid": 2,
                        "type": "00000023-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado Smart Radiator Thermostat VA1618619136",
                        "format": "string",
                        "typeLabel": "name"
                    }, {
                        "iid": 3,
                        "type": "00000020-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado",
                        "format": "string",
                        "typeLabel": "manufacturer"
                    }, {
                        "iid": 4,
                        "type": "00000030-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "VA1618619136",
                        "format": "string",
                        "typeLabel": "serial-number"
                    }, {
                        "iid": 5,
                        "type": "00000021-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "SRT01",
                        "format": "string",
                        "typeLabel": "model"
                    }, {
                        "iid": 6,
                        "type": "00000052-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "95.1",
                        "format": "string",
                        "typeLabel": "firmware.revision"
                    }, {
                        "iid": 7,
                        "type": "00000014-0000-1000-8000-0026BB765291",
                        "perms": ["pw"],
                        "format": "bool",
                        "typeLabel": "identify"
                    }
                ],
                "typeLabel": "accessory-information"
            }, {
                "type": "E44673A0-247B-4360-8A76-DB9DA69C0100",
                "iid": 8,
                "primary": false,
                "hidden": true,
                "characteristics": [{
                        "iid": 9,
                        "type": "E44673A0-247B-4360-8A76-DB9DA69C0101",
                        "perms": ["pw"],
                        "format": "string",
                        "typeLabel": "E44673A0-247B-4360-8A76-DB9DA69C0101"
                    }
                ],
                "typeLabel": "E44673A0-247B-4360-8A76-DB9DA69C0100"
            }, {
                "type": "0000004A-0000-1000-8000-0026BB765291",
                "iid": 10,
                "primary": true,
                "hidden": false,
                "characteristics": [{
                        "iid": 11,
                        "type": "00000023-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado Smart Radiator Thermostat VA1618619136",
                        "format": "string",
                        "typeLabel": "name"
                    }, {
                        "iid": 12,
                        "type": "0000000F-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "ev"],
                        "value": 0,
                        "maxValue": 2,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "uint8",
                        "typeLabel": "heating-cooling.current"
                    }, {
                        "iid": 13,
                        "type": "00000033-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "pw", "ev"],
                        "value": 1,
                        "maxValue": 1,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "uint8",
                        "typeLabel": "heating-cooling.target"
                    }, {
                        "iid": 14,
                        "type": "00000011-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "ev"],
                        "value": 19.7,
                        "maxValue": 100,
                        "minValue": 0,
                        "minStep": 0.1,
                        "format": "float",
                        "unit": "celsius",
                        "typeLabel": "temperature.current"
                    }, {
                        "iid": 15,
                        "type": "00000035-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "pw", "ev"],
                        "value": 17,
                        "maxValue": 25,
                        "minValue": 5,
                        "minStep": 0.1,
                        "format": "float",
                        "unit": "celsius",
                        "typeLabel": "temperature.target"
                    }, {
                        "iid": 16,
                        "type": "00000036-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "pw", "ev"],
                        "value": 0,
                        "maxValue": 1,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "uint8",
                        "typeLabel": "temperature.units"
                    }, {
                        "iid": 17,
                        "type": "00000010-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "ev"],
                        "value": 55,
                        "maxValue": 100,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "float",
                        "unit": "percentage",
                        "typeLabel": "relative-humidity.current"
                    }
                ],
                "typeLabel": "thermostat"
            }
        ]
    }, {
        "aid": 5,
        "services": [{
                "type": "0000003E-0000-1000-8000-0026BB765291",
                "iid": 1,
                "primary": false,
                "hidden": false,
                "characteristics": [{
                        "iid": 2,
                        "type": "00000023-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado Smart Radiator Thermostat VA0746269440",
                        "format": "string",
                        "typeLabel": "name"
                    }, {
                        "iid": 3,
                        "type": "00000020-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado",
                        "format": "string",
                        "typeLabel": "manufacturer"
                    }, {
                        "iid": 4,
                        "type": "00000030-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "VA0746269440",
                        "format": "string",
                        "typeLabel": "serial-number"
                    }, {
                        "iid": 5,
                        "type": "00000021-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "SRT01",
                        "format": "string",
                        "typeLabel": "model"
                    }, {
                        "iid": 6,
                        "type": "00000052-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "95.1",
                        "format": "string",
                        "typeLabel": "firmware.revision"
                    }, {
                        "iid": 7,
                        "type": "00000014-0000-1000-8000-0026BB765291",
                        "perms": ["pw"],
                        "format": "bool",
                        "typeLabel": "identify"
                    }
                ],
                "typeLabel": "accessory-information"
            }, {
                "type": "E44673A0-247B-4360-8A76-DB9DA69C0100",
                "iid": 8,
                "primary": false,
                "hidden": true,
                "characteristics": [{
                        "iid": 9,
                        "type": "E44673A0-247B-4360-8A76-DB9DA69C0101",
                        "perms": ["pw"],
                        "format": "string",
                        "typeLabel": "E44673A0-247B-4360-8A76-DB9DA69C0101"
                    }
                ],
                "typeLabel": "E44673A0-247B-4360-8A76-DB9DA69C0100"
            }, {
                "type": "0000004A-0000-1000-8000-0026BB765291",
                "iid": 10,
                "primary": true,
                "hidden": false,
                "characteristics": [{
                        "iid": 11,
                        "type": "00000023-0000-1000-8000-0026BB765291",
                        "perms": ["pr"],
                        "value": "tado Smart Radiator Thermostat VA0746269440",
                        "format": "string",
                        "typeLabel": "name"
                    }, {
                        "iid": 12,
                        "type": "0000000F-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "ev"],
                        "value": 0,
                        "maxValue": 2,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "uint8",
                        "typeLabel": "heating-cooling.current"
                    }, {
                        "iid": 13,
                        "type": "00000033-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "pw", "ev"],
                        "value": 1,
                        "maxValue": 1,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "uint8",
                        "typeLabel": "heating-cooling.target"
                    }, {
                        "iid": 14,
                        "type": "00000011-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "ev"],
                        "value": 20,
                        "maxValue": 100,
                        "minValue": 0,
                        "minStep": 0.1,
                        "format": "float",
                        "unit": "celsius",
                        "typeLabel": "temperature.current"
                    }, {
                        "iid": 15,
                        "type": "00000035-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "pw", "ev"],
                        "value": 17,
                        "maxValue": 25,
                        "minValue": 5,
                        "minStep": 0.1,
                        "format": "float",
                        "unit": "celsius",
                        "typeLabel": "temperature.target"
                    }, {
                        "iid": 16,
                        "type": "00000036-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "pw", "ev"],
                        "value": 0,
                        "maxValue": 1,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "uint8",
                        "typeLabel": "temperature.units"
                    }, {
                        "iid": 17,
                        "type": "00000010-0000-1000-8000-0026BB765291",
                        "perms": ["pr", "ev"],
                        "value": 58,
                        "maxValue": 100,
                        "minValue": 0,
                        "minStep": 1,
                        "format": "float",
                        "unit": "percentage",
                        "typeLabel": "relative-humidity.current"
                    }
                ],
                "typeLabel": "thermostat"
            }
        ]
    }
]
NebzHB commented 2 years ago

So it seems that the tado bridge here and there kills all connections at the same timepoint as your log shows.

not sure it does... cause by example here is another part of the logs (mixed with event from other device that works fine) :

[09-05-2022 13:17:56][DEBUG] : Event-disconnect from tado Internet Bridge IB3005030144 : 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:17:56][DEBUG] : Resubscribe in progress for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
[09-05-2022 13:17:56][DEBUG] : Resubscibe successfull for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:19:08][DEBUG] : Event-disconnect from tado Internet Bridge IB3005030144 : 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:19:08][DEBUG] : Resubscribe in progress for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
[09-05-2022 13:19:08][DEBUG] : Resubscibe successfull for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:20:19][DEBUG] : Event-disconnect from tado Internet Bridge IB3005030144 : 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:20:19][DEBUG] : Resubscribe in progress for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
[09-05-2022 13:20:19][DEBUG] : Resubscibe successfull for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:20:20][INFO] : Event reçu de Aqara-Hub-M1S-3774 : status-lo-batt=0
[09-05-2022 13:21:31][DEBUG] : Event-disconnect from tado Internet Bridge IB3005030144 : 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:21:31][DEBUG] : Resubscribe in progress for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
[09-05-2022 13:21:31][DEBUG] : Resubscibe successfull for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:22:43][DEBUG] : Event-disconnect from tado Internet Bridge IB3005030144 : 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:22:43][DEBUG] : Resubscribe in progress for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
[09-05-2022 13:22:43][DEBUG] : Resubscibe successfull for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:23:40][INFO] : Event reçu de Aqara-Hub-M1S-3774 : light-level.current=10854
[09-05-2022 13:23:49][INFO] : Event reçu de Aqara-Hub-M1S-3774 : status-lo-batt=0
[09-05-2022 13:23:54][DEBUG] : Event-disconnect from tado Internet Bridge IB3005030144 : 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:23:54][DEBUG] : Resubscribe in progress for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
[09-05-2022 13:23:55][DEBUG] : Resubscibe successfull for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:24:00][INFO] : Event reçu de Aqara-Hub-M1S-3774 : light-level.current=8562
[09-05-2022 13:24:10][INFO] : Event reçu de Aqara-Hub-M1S-3774 : light-level.current=7360
[09-05-2022 13:24:15][INFO] : Event reçu de Aqara-Hub-M1S-3774 : status-lo-batt=0
[09-05-2022 13:24:20][INFO] : Event reçu de Aqara-Hub-M1S-3774 : light-level.current=8425
[09-05-2022 13:24:25][INFO] : Event reçu de Aqara-Hub-M1S-3774 : light-level.current=10268
[09-05-2022 13:24:40][INFO] : Event reçu de Aqara-Hub-M1S-3774 : light-level.current=13471
[09-05-2022 13:25:06][DEBUG] : Event-disconnect from tado Internet Bridge IB3005030144 : 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:25:06][DEBUG] : Resubscribe in progress for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
[09-05-2022 13:25:06][DEBUG] : Resubscibe successfull for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:25:34][INFO] : Event reçu de Aqara-Hub-M1S-3774 : status-lo-batt=0
[09-05-2022 13:25:42][INFO] : Event reçu de Aqara-Hub-M1S-3774 : status-lo-batt=0
[09-05-2022 13:26:18][DEBUG] : Event-disconnect from tado Internet Bridge IB3005030144 : 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:26:18][DEBUG] : Resubscribe in progress for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
[09-05-2022 13:26:18][DEBUG] : Resubscibe successfull for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:27:29][DEBUG] : Event-disconnect from tado Internet Bridge IB3005030144 : 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17
[09-05-2022 13:27:29][DEBUG] : Resubscribe in progress for  tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17...
[09-05-2022 13:27:30][DEBUG] : Resubscibe successfull for tado Internet Bridge IB3005030144 on 2.12,2.13,2.14,2.15,2.16,2.17,3.12,3.13,3.14,3.15,3.16,3.17,4.12,4.13,4.14,4.15,4.16,4.17,5.12,5.13,5.14,5.15,5.16,5.17

that's alot of event-disconnect without even a setCharacteristic ! (that was before enabling debug, that part of the log was more explainatory)

NebzHB commented 2 years ago

I've asked the user to change his network cable, just in case... cause so many disconnect it's strange... or does it wait for a sort of ping-pong (keepalive) to keep the subscription channel open ? or another header telling him to keep it open ?

Apollon77 commented 2 years ago

The "keepalive" is done on the network connection level and here the library sets it correctly ... And it is also the "only" time I see it ... and that it works for other devices proofs that lib dos it at least basically right ... Honestly ... no idea.

Did ever updates were coming vis the subscription iff the user controls something "beside" the library?

NebzHB commented 2 years ago

yes i have alot of users using plenty of devices too without any issues... i'm wondering if tado does something different than the other or just stuck more precisely to the norm... yes he get updates correctly (when there is no event-disconnect then reconnect of course).

i guess we are still in the dark about tado... would it help if I order one from amazon (and will send it back for refund few weeks after that) and i give you ssh access to one of my system ? or only trial/error approach will help ?

Apollon77 commented 2 years ago

This is a good question. Fort the last issue we fixed it ws helpful to have the device directly there and so were also able to do short curl tests and such "fast experiments" ... if it will bring that much in this case ...

In fact the "only idea left" that I have is that tado only allows "one connection by the controller" ...this would mean that we need to use the same persistent connection for calls AND subscription. I could try that.

Can you let the user test with lib from GitHub or do I need to release that change first?

NebzHB commented 2 years ago

release is much simplier... or a tag (anything behind the @ in the package.json)

Apollon77 commented 2 years ago

Ok, if you like I would be happy about a review because coded blind

https://github.com/Apollon77/hap-controller-node/commit/3a3958cc9787b2bffd64651d5bc78a72e9b4e33e

should be available as pre-release v0.8.0-alpha.0 soon on npm.

You need to set the new flag in the http-client options. Please also check for devices that normally work :-)

Apollon77 commented 2 years ago

v0.8.0-alpha.0 released and npm latest re-set to 0.7.4

NebzHB commented 2 years ago

ok, pushed to beta on my side, i'll let you know the outcomes...

i've set the flag for every device (to be sure to test).

do you know if it's a global rule to use only one connection ? or if there is a mdns txt record telling us we have to use that ?

NebzHB commented 2 years ago

it seems that event are stuck until we ask for a getAccessories or something, then the event arrives... like it seems tado don't keep the connection again... and sometimes the events arrives... like just after a getAccessories for a time...

i'll maybe try without the permanent connection...