2021-12-16 05:59:16.997 - debug: homekit-controller.0 (1246082) Redis Objects: Use Redis connection: 127.0.0.1:9001 2021-12-16 05:59:17.052 - debug: homekit-controller.0 (1246082) Objects client ready ... initialize now 2021-12-16 05:59:17.062 - debug: homekit-controller.0 (1246082) Objects create System PubSub Client 2021-12-16 05:59:17.069 - debug: homekit-controller.0 (1246082) Objects create User PubSub Client 2021-12-16 05:59:17.074 - debug: homekit-controller.0 (1246082) Objects client initialize lua scripts 2021-12-16 05:59:17.136 - debug: homekit-controller.0 (1246082) Objects connected to redis: 127.0.0.1:9001 2021-12-16 05:59:17.153 - debug: homekit-controller.0 (1246082) objectDB connected 2021-12-16 05:59:17.159 - debug: homekit-controller.0 (1246082) Redis States: Use Redis connection: 127.0.0.1:6379 2021-12-16 05:59:17.179 - debug: homekit-controller.0 (1246082) States create System PubSub Client 2021-12-16 05:59:17.183 - debug: homekit-controller.0 (1246082) States create User PubSub Client 2021-12-16 05:59:17.201 - debug: homekit-controller.0 (1246082) States connected to redis: 127.0.0.1:6379 2021-12-16 05:59:17.205 - debug: homekit-controller.0 (1246082) statesDB connected 2021-12-16 05:59:17.527 - debug: homekit-controller.0 (1246082) Plugin sentry Initialize Plugin (enabled=true) 2021-12-16 05:59:17.765 - error: homekit-controller.0 (1246082) adapter disabled 2021-12-16 05:59:17.772 - info: homekit-controller.0 (1246082) starting. Version 0.3.3 in /opt/iobroker/node_modules/iobroker.homekit-controller, node: v14.18.2, js-controller: 3.3.21 2021-12-16 05:59:18.036 - debug: homekit-controller.0 (1246082) Init 2 known devices without discovery ... 2021-12-16 05:59:18.037 - debug: homekit-controller.0 (1246082) Init BLE-ED:B2:DF:50:92:D1 as known device 2021-12-16 05:59:18.039 - info: homekit-controller.0 (1246082) BLE-ED:B2:DF:50:92:D1 (Eve Room 632D) found without pairing data but available for pairing: Create basic objects 2021-12-16 05:59:18.041 - debug: homekit-controller.0 (1246082) Service: {"name":"Eve Room 632D","CoID":76,"TY":6,"AIL":49,"SF":1,"DeviceID":"ed:b2:df:50:92:d1","ACID":10,"GSN":3,"CN":1,"CV":2,"c#":1,"id":"ed:b2:df:50:92:d1","ci":10,"availableToPair":true} 2021-12-16 05:59:18.056 - debug: homekit-controller.0 (1246082) state homekit-controller.0.info.connection changed: false (ack = true) 2021-12-16 05:59:18.111 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-ED:B2:DF:50:92:D1.info.connectionType changed: BLE (ack = true) 2021-12-16 05:59:18.123 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-ED:B2:DF:50:92:D1.info.id changed: ed:b2:df:50:92:d1 (ack = true) 2021-12-16 05:59:18.137 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-ED:B2:DF:50:92:D1.info.connected changed: false (ack = true) 2021-12-16 05:59:18.174 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-ED:B2:DF:50:92:D1.admin.isPaired changed: false (ack = true) 2021-12-16 05:59:18.188 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-ED:B2:DF:50:92:D1.info.lastDiscovered changed: 1639630758044 (ack = true) 2021-12-16 05:59:18.204 - debug: homekit-controller.0 (1246082) Init BLE-7A:16:1F:F5:47:C1 as known device 2021-12-16 05:59:18.206 - info: homekit-controller.0 (1246082) BLE-7A:16:1F:F5:47:C1 (Eve Degree 053B) found without pairing data but available for pairing: Create basic objects 2021-12-16 05:59:18.207 - debug: homekit-controller.0 (1246082) Service: {"name":"Eve Degree 053B","CoID":76,"TY":6,"AIL":49,"SF":1,"DeviceID":"7a:16:1f:f5:47:c1","ACID":10,"GSN":1,"CN":3,"CV":2,"c#":3,"id":"7a:16:1f:f5:47:c1","ci":10,"availableToPair":true} 2021-12-16 05:59:18.242 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-7A:16:1F:F5:47:C1.info.connectionType changed: BLE (ack = true) 2021-12-16 05:59:18.255 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-7A:16:1F:F5:47:C1.info.id changed: 7a:16:1f:f5:47:c1 (ack = true) 2021-12-16 05:59:18.267 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-7A:16:1F:F5:47:C1.info.connected changed: false (ack = true) 2021-12-16 05:59:18.285 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-7A:16:1F:F5:47:C1.admin.isPaired changed: false (ack = true) 2021-12-16 05:59:18.303 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-7A:16:1F:F5:47:C1.info.lastDiscovered changed: 1639630758209 (ack = true) 2021-12-16 05:59:18.321 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-7A:16:1F:F5:47:C1.admin.pairWithPin changed: (ack = true) 2021-12-16 05:59:18.336 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-7A:16:1F:F5:47:C1.admin.identify changed: false (ack = true) 2021-12-16 05:59:19.555 - debug: homekit-controller.0 (1246082) Discovered BLE device up: 7a:16:1f:f5:47:c1/Eve Degree 053B 2021-12-16 05:59:19.556 - debug: homekit-controller.0 (1246082) BLE-7A:16:1F:F5:47:C1 Discovered BLE device: {"name":"Eve Degree 053B","CoID":76,"TY":6,"AIL":49,"SF":0,"DeviceID":"7a:16:1f:f5:47:c1","ACID":10,"GSN":6,"CN":3,"CV":2,"c#":3,"id":"7a:16:1f:f5:47:c1","ci":10,"availableToPair":false} 2021-12-16 05:59:19.558 - info: homekit-controller.0 (1246082) BLE-7A:16:1F:F5:47:C1 Found stored Pairing data, try it ... 2021-12-16 05:59:19.559 - debug: homekit-controller.0 (1246082) BLE-7A:16:1F:F5:47:C1 Start Homekit Device Client initialization 2021-12-16 05:59:19.561 - debug: homekit-controller.0 (1246082) Service: {"name":"Eve Degree 053B","CoID":76,"TY":6,"AIL":49,"SF":0,"DeviceID":"7a:16:1f:f5:47:c1","ACID":10,"GSN":6,"CN":3,"CV":2,"c#":3,"id":"7a:16:1f:f5:47:c1","ci":10,"availableToPair":false} 2021-12-16 05:59:19.585 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-7A:16:1F:F5:47:C1.admin.pairWithPin deleted 2021-12-16 05:59:19.609 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-7A:16:1F:F5:47:C1.admin.identify deleted 2021-12-16 05:59:19.626 - debug: homekit-controller.0 (1246082) BLE-7A:16:1F:F5:47:C1 Request Accessory information hap-controller:gatt-connection connect peripheral +0ms 2021-12-16 05:59:22.691 - debug: homekit-controller.0 (1246082) Discovered BLE device up: ed:b2:df:50:92:d1/Eve Room 632D 2021-12-16 05:59:22.692 - debug: homekit-controller.0 (1246082) BLE-ED:B2:DF:50:92:D1 Discovered BLE device: {"name":"Eve Room 632D","CoID":76,"TY":6,"AIL":49,"SF":1,"DeviceID":"ed:b2:df:50:92:d1","ACID":10,"GSN":3,"CN":1,"CV":2,"c#":1,"id":"ed:b2:df:50:92:d1","ci":10,"availableToPair":true} 2021-12-16 05:59:22.693 - info: homekit-controller.0 (1246082) BLE-ED:B2:DF:50:92:D1 (Eve Room 632D) found without pairing data but available for pairing: Create basic objects 2021-12-16 05:59:22.694 - debug: homekit-controller.0 (1246082) Service: {"name":"Eve Room 632D","CoID":76,"TY":6,"AIL":49,"SF":1,"DeviceID":"ed:b2:df:50:92:d1","ACID":10,"GSN":3,"CN":1,"CV":2,"c#":1,"id":"ed:b2:df:50:92:d1","ci":10,"availableToPair":true} 2021-12-16 05:59:22.744 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-ED:B2:DF:50:92:D1.info.connectionType changed: BLE (ack = true) 2021-12-16 05:59:22.766 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-ED:B2:DF:50:92:D1.info.id changed: ed:b2:df:50:92:d1 (ack = true) 2021-12-16 05:59:22.783 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-ED:B2:DF:50:92:D1.info.connected changed: false (ack = true) 2021-12-16 05:59:22.802 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-ED:B2:DF:50:92:D1.admin.isPaired changed: false (ack = true) 2021-12-16 05:59:22.815 - debug: homekit-controller.0 (1246082) state homekit-controller.0.BLE-ED:B2:DF:50:92:D1.info.lastDiscovered changed: 1639630762696 (ack = true) hap-controller:gatt-connection Peripheral disconnected +13s noble warning: unknown peripheral d9586108e7d9 noble warning: unknown peripheral d9586108e7d9 2021-12-16 06:00:04.638 - info: homekit-controller.0 (1246082) BLE-7A:16:1F:F5:47:C1 Could not initialize device: TimeoutError: at Object. (/opt/iobroker/node_modules/p-queue/dist/index.js:8:22) at Module._compile (internal/modules/cjs/loader.js:1085:14) at Object.Module._extensions..js (internal/modules/cjs/loader.js:1114:10) at Module.load (internal/modules/cjs/loader.js:950:32) at Function.Module._load (internal/modules/cjs/loader.js:790:12) at Module.require (internal/modules/cjs/loader.js:974:19) at require (internal/modules/cjs/helpers.js:93:18) at Object. (/opt/iobroker/node_modules/iobroker.homekit-controller/build/main.js:38:35) at Module._compile (internal/modules/cjs/loader.js:1085:14) at Object.Module._extensions..js (internal/modules/cjs/loader.js:1114:10) noble warning: unknown peripheral d9586108e7d9 noble warning: unknown peripheral d9586108e7d9 noble warning: unknown peripheral d9586108e7d9 noble warning: unknown peripheral d9586108e7d9 hap-controller:gatt-connection connect peripheral +3m hap-controller:gatt-connection d9586108e7d9/d9:58:61:08:e7:d9 Write for characteristic 000000a50000100080000026bb765291 0006001600 +2s hap-controller:gatt-connection disconnect peripheral +1ms hap-controller:gatt-connection Peripheral disconnected +37ms 2021-12-16 06:05:37.145 - debug: homekit-controller.0 (1246082) Message getDiscoveredDevices received: {"command":"getDiscoveredDevices","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":661,"ack":false,"time":1639631137142},"_id":54082247}) 2021-12-16 06:05:37.146 - debug: homekit-controller.0 (1246082) Response to Command getDiscoveredDevices: {"success":true,"error":false,"devices":[{"id":"BLE-7A:16:1F:F5:47:C1","serviceType":"BLE","connected":false,"discovered":true,"availableToPair":false,"discoveredName":"Eve Degree 053B","discoveredCategory":"Sensor","pairedWithThisInstance":true},{"id":"BLE-ED:B2:DF:50:92:D1","serviceType":"BLE","connected":false,"discovered":true,"availableToPair":true,"discoveredName":"Eve Room 632D","discoveredCategory":"Sensor","pairedWithThisInstance":false}]} 2021-12-16 06:05:37.148 - debug: homekit-controller.0 (1246082) sendTo "getDiscoveredDevices" to system.adapter.admin.0 from system.adapter.homekit-controller.0 2021-12-16 06:07:08.833 - debug: homekit-controller.0 (1246082) Discovered BLE device changed: 7a:16:1f:f5:47:c1/Eve Degree 053B 2021-12-16 06:07:08.834 - debug: homekit-controller.0 (1246082) BLE-7A:16:1F:F5:47:C1 Discovered BLE device: {"name":"Eve Degree 053B","CoID":76,"TY":6,"AIL":49,"SF":0,"DeviceID":"7a:16:1f:f5:47:c1","ACID":10,"GSN":7,"CN":3,"CV":2,"c#":3,"id":"7a:16:1f:f5:47:c1","ci":10,"availableToPair":false} 2021-12-16 06:07:08.834 - debug: homekit-controller.0 (1246082) BLE-7A:16:1F:F5:47:C1 Start Homekit Device Client initialization 2021-12-16 06:07:08.835 - debug: homekit-controller.0 (1246082) Service: {"name":"Eve Degree 053B","CoID":76,"TY":6,"AIL":49,"SF":0,"DeviceID":"7a:16:1f:f5:47:c1","ACID":10,"GSN":7,"CN":3,"CV":2,"c#":3,"id":"7a:16:1f:f5:47:c1","ci":10,"availableToPair":false} 2021-12-16 06:07:08.840 - debug: homekit-controller.0 (1246082) BLE-7A:16:1F:F5:47:C1 Request Accessory information hap-controller:gatt-connection connect peripheral +5m 2021-12-16 06:07:19.084 - debug: homekit-controller.0 (1246082) Discovered BLE device changed: 7a:16:1f:f5:47:c1/Eve Degree 053B 2021-12-16 06:07:19.085 - debug: homekit-controller.0 (1246082) BLE-7A:16:1F:F5:47:C1 Discovered BLE device: {"name":"Eve Degree 053B","CoID":76,"TY":6,"AIL":49,"SF":0,"DeviceID":"7a:16:1f:f5:47:c1","ACID":10,"GSN":8,"CN":3,"CV":2,"c#":3,"id":"7a:16:1f:f5:47:c1","ci":10,"availableToPair":false} 2021-12-16 06:07:19.085 - debug: homekit-controller.0 (1246082) BLE-7A:16:1F:F5:47:C1 Device initialization already in progress ... ignore call hap-controller:gatt-connection Peripheral disconnected +10s noble warning: unknown peripheral d9586108e7d9 noble warning: unknown peripheral d9586108e7d9 2021-12-16 06:07:53.842 - info: homekit-controller.0 (1246082) BLE-7A:16:1F:F5:47:C1 Could not initialize device: TimeoutError: at Object. (/opt/iobroker/node_modules/p-queue/dist/index.js:8:22) at Module._compile (internal/modules/cjs/loader.js:1085:14) at Object.Module._extensions..js (internal/modules/cjs/loader.js:1114:10) at Module.load (internal/modules/cjs/loader.js:950:32) at Function.Module._load (internal/modules/cjs/loader.js:790:12) at Module.require (internal/modules/cjs/loader.js:974:19) at require (internal/modules/cjs/helpers.js:93:18) at Object. (/opt/iobroker/node_modules/iobroker.homekit-controller/build/main.js:38:35) at Module._compile (internal/modules/cjs/loader.js:1085:14) at Object.Module._extensions..js (internal/modules/cjs/loader.js:1114:10) noble warning: unknown peripheral d9586108e7d9 noble warning: unknown peripheral d9586108e7d9 noble warning: unknown peripheral d9586108e7d9 noble warning: unknown peripheral d9586108e7d9 hap-controller:gatt-connection connect peripheral +3m hap-controller:gatt-connection d9586108e7d9/d9:58:61:08:e7:d9 Write for characteristic 000000a50000100080000026bb765291 0006011600 +2s hap-controller:gatt-connection disconnect peripheral +1ms hap-controller:gatt-connection Peripheral disconnected +37ms