2021-01-18 21:49:49.336 [TRACE] [thub.hapjava.server.impl.HomekitRoot] - Removed accessory java.util.concurrent.CompletableFuture@a3ce16[Completed normally]

2021-01-18 21:49:49.340 [TRACE] [pl.http.impl.NettyHomekitHttpService] - Resetting connections

2021-01-18 21:49:49.343 [TRACE] [penhab.io.homekit.internal.Debouncer] - stop debouncer

2021-01-18 21:49:49.349 [TRACE] [rver.impl.http.impl.AccessoryHandler] - Terminated HomeKit connection from /192.168.2.171:50999

2021-01-18 21:49:49.351 [TRACE] [thub.hapjava.server.impl.HomekitRoot] - Removed accessory java.util.concurrent.CompletableFuture@16a0dbe[Completed normally]

2021-01-18 21:49:49.354 [TRACE] [pl.http.impl.NettyHomekitHttpService] - Resetting connections

2021-01-18 21:49:51.404 [TRACE] [impl.connections.SubscriptionManager] - Removing 1 reverse connections from subscription manager

2021-01-18 21:49:51.406 [TRACE] [impl.connections.SubscriptionManager] - Removing connection 31849175

2021-01-18 21:49:51.414 [TRACE] [impl.connections.SubscriptionManager] - Unsubscribing from characteristic as all subscriptions are closed

2021-01-18 21:49:51.417 [TRACE] [impl.connections.SubscriptionManager] - Unsubscribing from characteristic as all subscriptions are closed

2021-01-18 21:49:51.419 [TRACE] [impl.connections.SubscriptionManager] - Removed connection 31849175

2021-01-18 21:49:51.421 [TRACE] [impl.connections.SubscriptionManager] - Subscription sizes are 0 and 0

2021-01-18 21:49:51.637 [TRACE] [mekit.internal.HomekitChangeListener] - Item homekit_gTW is a HomeKit accessory of types [LIGHTBULB=EMPTY]

2021-01-18 21:49:51.640 [TRACE] [.accessories.HomekitAccessoryFactory] - Constructing homekit_gTW of accessory type Lighting

2021-01-18 21:49:51.644 [TRACE] [.accessories.HomekitAccessoryFactory] - Mandatory characteristics for item homekit_gTW characteristics [Item:homekit_tw_bright (Type=DimmerItem, State=72, Label=mytw_bright, Category=null, Groups=[homekit_gTW])  HomeKit type:LIGHTBULB HomeKit characteristic:ON_STATE]

2021-01-18 21:49:51.648 [TRACE] [.accessories.HomekitAccessoryFactory] - Optional characteristics for item homekit_gTW characteristics {BRIGHTNESS=homekit_tw_bright (Type=DimmerItem, State=72, Label=mytw_bright, Category=null, Groups=[homekit_gTW])}

2021-01-18 21:49:51.652 [TRACE] [ssories.HomekitCharacteristicFactory] - CreateCharacteristic, type BRIGHTNESS item Item:homekit_tw_bright (Type=DimmerItem, State=72, Label=mytw_bright, Category=null, Groups=[homekit_gTW])  HomeKit type:LIGHTBULB HomeKit characteristic:BRIGHTNESS

2021-01-18 21:49:51.678 [INFO ] [mekit.internal.HomekitChangeListener] - Created 1 HomeKit items.

2021-01-18 21:49:51.703 [TRACE] [thub.hapjava.server.impl.HomekitRoot] - Added accessory java.util.concurrent.CompletableFuture@14ad2de[Completed normally]

2021-01-18 21:49:51.706 [TRACE] [thub.hapjava.server.impl.HomekitRoot] - Added accessory java.util.concurrent.CompletableFuture@ea7a36[Completed normally]

2021-01-18 21:49:51.750 [TRACE] [pl.http.impl.NettyHomekitHttpService] - Bound homekit listener to /192.168.2.99:9124

2021-01-18 21:49:51.753 [TRACE] [er.impl.jmdns.JmdnsHomekitAdvertiser] - Advertising accessory openHAB

2021-01-18 21:49:51.755 [INFO ] [er.impl.jmdns.JmdnsHomekitAdvertiser] - Registering _hap._tcp.local. on port 9124

2021-01-18 21:49:55.973 [TRACE] [rver.impl.http.impl.AccessoryHandler] - New HomeKit connection from /192.168.2.171:51002

2021-01-18 21:49:55.975 [TRACE] [server.impl.http.impl.LoggingHandler] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 158, cap: 1024) [/192.168.2.171:51002]:

504F5354202F706169722D76657269667920485454502F312E310D0A486F73743A206F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A2033370D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A06010103202A3D8B8BBE1856D51AA46E5B58961554A205D8C675F6D63678ED54D95B384D74

2021-01-18 21:49:55.979 [TRACE] [impl.pairing.PairVerificationManager] - Starting pair verification for openHAB

2021-01-18 21:49:55.999 [TRACE] [er.impl.http.HomekitClientConnection] - 200 /pair-verify

2021-01-18 21:49:56.003 [TRACE] [server.impl.http.impl.LoggingHandler] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 244, cap: 256) [/192.168.2.171:51002]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A203134300D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A0601020565C46C594AE379807DDC9CFEAA2D2B0B70B90C74B958F264593A448E43700FA153390FA940F07C0C23985E9AA2613B388DD6B06BB0E72B5C2DE1D682DF5BB5C1AC3B09D8E6DF7D16F415D841434D6D253E9560C5AF581768A35A7DE6B953116E4FFDFA72339D0320458D93A0E353BEB78C280CE8A3FC79792E0C6B4655282862B6F0D9AC36224A43

2021-01-18 21:49:56.022 [TRACE] [server.impl.http.impl.LoggingHandler] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 247, cap: 1024) [/192.168.2.171:51002]:

504F5354202F706169722D76657269667920485454502F312E310D0A486F73743A206F70656E4841422E5F6861702E5F7463702E6C6F63616C0D0A436F6E74656E742D4C656E6774683A203132350D0A436F6E74656E742D547970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A0D0A0578B9161B21728F699B9542A5ED7369258C73ABBE158ADD588C5AD871D234FE8A858E11E9A142590EA29D43F1A5C54E9F37420230C3DF1C3F501A39485300CB88C47C264BE0D43FB9476F3D7A0C87A81811DF4341D9177F90FA7E30B5464ADF6A438E7E5322C6F7CBF4DAEF587C3CF14FDECC2BE5E6D3783043060103

2021-01-18 21:49:56.045 [TRACE] [impl.pairing.PairVerificationManager] - Completed pair verification for openHAB

2021-01-18 21:49:56.048 [TRACE] [er.impl.http.HomekitClientConnection] - 200 /pair-verify

2021-01-18 21:49:56.053 [TRACE] [server.impl.http.impl.LoggingHandler] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 105, cap: 256) [/192.168.2.171:51002]:

485454502F312E3120323030204F4B0D0A436F6E74656E742D747970653A206170706C69636174696F6E2F70616972696E672B746C76380D0A436F6E74656E742D4C656E6774683A20330D0A436F6E6E656374696F6E3A206B6565702D616C6976650D0A0D0A060104

2021-01-18 21:49:56.061 [TRACE] [server.impl.http.impl.LoggingHandler] - READ SimpleLeakAwareByteBuf(PooledUnsafeDirectByteBuf(ridx: 0, widx: 78, cap: 512)) [/192.168.2.171:51002]:

3C005C272097D409A6DC9D7D52FC01237477669FE9ACD7F420CDB4B00991B7C11314C1BDFA4D641FB8675BB58AA96106FEE81E77A11BCA723928113F196183C8D3E93A9E18C195C74020BBBA163E

2021-01-18 21:49:56.063 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Received message of length 78. Existing buffer is 0

2021-01-18 21:49:56.065 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Attempting to read message of length 78

2021-01-18 21:49:56.067 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Read complete message

2021-01-18 21:49:56.069 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Returning 1 results

2021-01-18 21:49:56.108 [TRACE] [er.impl.http.HomekitClientConnection] - 200 /accessories

2021-01-18 21:49:56.114 [TRACE] [server.impl.http.impl.LoggingHandler] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 2078, cap: 4096) [/192.168.2.171:51002]:

0004DB51BA0F4D45DBD7E89C82AD66EC3D680E4DDDB1EB890CE5129E9059E8C18B0FDF0526F8ADA5C43EFFD5F615087C15AE02224FDC448302101B2455910705524B4F204BAB562EE347B761DA12715D4D20C79F514F11BDD0EBA86E6D40FFB454B1241DB7CF64A77051F8E12022BC96B4EEC997E207C96A5746A0956ED4B6FE2160DA61E296A62BE233C5952894CF602DD9291ADE413F8B99EF87C5B6769BF6FF37467F816A806EF6146D21F734059A7C12205A5B968D139E68FCBD7CE4176BF4FF8C7EDF82211507BC9EC2A91DB0B1E07245F74D47B6592B353B2F6D86AA21419D97C1485A9DF9230ABCAE9544B85A67E586ABA4A3CFE9A6C07F23FBF54BFCB591EBD272FCC8E820E7ED98A03EC594EA973DC35253102E02BF7F70BD39F42C5F19B14200BD2290E39A170BAA44B3D4C24B5E31E6B1DDD01EA84E8DE2C407677D6276C0EF3D7CED7AD9C083CBFF1D16F406CE6044600BD01BDB177BD68064E351B8422A925136FF325D7DE5F2016445547F22F5D840287AA4940D17CB93703DD61453823493E65E8B6E17175F586FF07E4C2FAF75BDB252EDA8AB8D2678B7777D8F180CE4B068D2E6B04AA766164BE42B1374B3CC53E55659612C31FE652F8719CC628F0CE34FD8B60870A17C7B083F366FEC34095E5D111E5546BAEDBEBC7DA389AA3FB849EE769927507030529DEE05476A0F19C3D1AC97341FFFD63FE9FCFF5E4EF8353301FA54DD70F9A57AF10D07B9BB46DA9BB5BDAA9D193B1AF87EA458406088B9FA1FB48705BAAC97D4C7C46BB50077BE36CE61A9D004E17A1E9874C75F7E6DAAAB22BBE158D16840EDF5EA22C8814D1863D212CBA32293C8693FCF88A33327986A5DB95B42D3BBD75528BE26979F22A37D568AA6DFD42E19645B5783CFD5348DD6F8421BA79694BC39472BEDDC3940FE6412F845DE386F6B100D45B31CC3304011466858AC3CAFB64C0036717B56ADDA744EDEE25139C7C888207D43904E1C2176F7F9CD7AF77FC727C1A5AC9BDD2D26945D92BEEFB6D08A44AEF02D64F54A5B2B83025CFA02884EF768D7EFE257FD982818BC9AEB784B8878F0F8C6407F4F9AF81047DA4B4389B7057876A2BB8A55BD6DDF163B29F096E5F19267A14B2DA96E39B115BE115D616C565A75BC7A5FBACB42A5209560B096C7F7BF003F7FB143C323CF86929BE21177CB1A4F61C8F924C4B87F7081285B15238C506356527B6EB564007D2F97635B14887FADC4A08683CFF2D9578545DB41132127C87E4C43E93247DBA8E0E4239357CBBF0D7859C6F5B11D294E944B4D09E49EE12256E9262C301A2AF120B5C02F336B64998C3B4075C717124EBFB1648EA37D1913720286E22D8B4235C5ED7D1746C99F0CBF20478A91267DB2D20D3CE9A52F06E40798A2EA5F22CE72B7BB663FEC84391F79D8357387CC6F3BBE79BE271F755FADC0816430B6E151335E5992C21B41807EC568FA03F18F7C2BA3880B27648A14D00B28E1FA0EA8AEF268040D6D764BB9236CD8EB577BD47B9D859193D3FF861A3D282BEA70AD6420C4C3EF45F77028CEE91E4389658EA0031AE1DF59D6A8B3AE84658586B447D52B2F544A74521749E3931602D0911A4850511560A49E5F8F7EA7FDDE42FF1C0467BEBE0454AF4C3F6F8280E2CF061B7C7806875C66B37BD39AFA3D5F3EE37F13A9146FAE9815DF383F7D638D56E331A3397F73864DAEEE245BFC7F266A9464DEE520EEC0AA01F092B0D856C747E9DC528D4F79ED57799E766F1E29AFCE63BF3E090FEA1DCABB6F3FA2D05F6BFB30F675628EB6931C91F1598567DDA1AE7EFE4B2A95D8A5AE09D597970105204EC19850496B988E0B3CA2D5BDFCA5C798F950DADEB77E864A1CE6133A6DBC1E247D3AF720DD33DC919178B06A32FF9F669714BD89E066D838E0E9D97F2B2AD2BDB88CEA7C5F361EA3621273B98D8FED298E67CB428910146D2EAB24625091FE8C8BE5AB5EC1F11FBF971C50FE1E0ECBD48A9771DBC1CB310FD60F4A7803D317BC0C8B685F8A53E3D672F3430C03FD0A7B10DDDDA8812FAD7B4C08932659F2C21E9FB1781AC147289B1EE68380927FCB43386A22294F641F1B30D0C3CA5C5845B8686AE8CC4ECB67B24EBCCFC833A68DCF7786A5F91F993927E07063796EFD67A6F6E4A45D027FD6D3B262A7439CF84617F3B24C7458A4690F49CFA5C3BF66AF5A57CF44211BD936885C9E3162F3B0F0040450508FA302BC6A700F69B8FFA09D61063933A2BB8E6EBBB8AC525ACACDFB93D4AF2D9FD24719D9C1460FCCBD9E99413AAE07881D2C3434581D4302F927D20A2418CC7B5F62F0F607DB03E4B4BE329E82EDF8EFE4FAF9696F3DF962B4B15213581771188296CBF878C18D0E816483E240662F49A884F82887185B651C4AD9479405AA0ACE1863FE806CA12182312E429C8120FF2F9B6C7EFE5F03CB51478FB551FA20285AE3339F6984A1C3A926AE263CFF30C4EC7049F695E82ABB28E77EE49352898FA8E0225D0F64AED3A1A94EA26F3F5955FA1A7C967A0557BEEDEC9A41A3100A46A616A0C5EB37AD0DA871BCFF9DB567456BB2143AB123C91D6195BB269D3B7CE8BD35D1B20FC2A72192B1396C857B358ECFAF99715A7ADD18CF0646573915AC0BBCD1C56ACD234BFA163FE0589B6DD529BCD6791FFBFD9929CEB889F3117FA8183CC30C4C5A54CF572B655299950FC7D43569619A83508ED5BA784F2A5FEA20EED99359D4DBE6B4A614A698D3C6212E49B8C1B2E95CE41F1F3F45330E0DFA88611AFAD203D53FD5DBF49661AF723B89B818B7A2FCD0ECA5E3CD1B4CF310F2C1DA9AC74D1FE79837F9894DD2FBD4F541EAA31F507B4182FE4A7016AAA9E61C8565D57A7630EC597DC1E4C4911ECD4BC222AAF3E7AB5335334601772BB3448C227595F1587661EFD707AF19354367AE8F9A05BA74FCEA0E33

2021-01-18 21:49:56.156 [TRACE] [server.impl.http.impl.LoggingHandler] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 234, cap: 512) [/192.168.2.171:51002]:

D8002F0376D17399E289BA0D46AB9934CFBFA3538129C1E30B34D2238147B12664E7CF8CE8491BF459D19A20AD6359D16D29C17C2F991C030761CFBE6F7588EC49CD2AC2A28E41FA74BFEE52744E902B67D3FAFAC820813CF825C8ADC123B16C2F3A10BC5B3D15FF4E31FC9D4FEDCF60E7263E2BF14A4490088DA40D5B35B22D990F318CAC4455FD7A5567449722A5DBB88393D75F5CCEA244FD89A186985F4710BD171537E5E7DA89813BDB9DF435F970F0A8A59E089F611086D0D82E189CC5C8A8667CBA44A2CACE7B8DC3F27DB22DEB1742085BFCA873B29B78B599B2FE6A1CA32A9917BA647C5B49

2021-01-18 21:49:56.158 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Received message of length 234. Existing buffer is 0

2021-01-18 21:49:56.161 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Attempting to read message of length 234

2021-01-18 21:49:56.162 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Read complete message

2021-01-18 21:49:56.165 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Returning 1 results

2021-01-18 21:49:56.170 [TRACE] [kit.internal.HomekitAccessoryUpdater] - Received subscription request for homekit_tw_bright (Type=DimmerItem, State=72, Label=mytw_bright, Category=null, Groups=[homekit_gTW]) / OnState

2021-01-18 21:49:56.172 [TRACE] [kit.internal.HomekitAccessoryUpdater] - Adding subscription for homekit_tw_bright (Type=DimmerItem, State=72, Label=mytw_bright, Category=null, Groups=[homekit_gTW]) / OnState

2021-01-18 21:49:56.175 [TRACE] [impl.connections.SubscriptionManager] - Added subscription to class io.github.hapjava.characteristics.impl.common.OnCharacteristic for 15886536

2021-01-18 21:49:56.177 [TRACE] [kit.internal.HomekitAccessoryUpdater] - Received subscription request for homekit_tw_bright (Type=DimmerItem, State=72, Label=mytw_bright, Category=null, Groups=[homekit_gTW]) / Brightness

2021-01-18 21:49:56.179 [TRACE] [kit.internal.HomekitAccessoryUpdater] - Adding subscription for homekit_tw_bright (Type=DimmerItem, State=72, Label=mytw_bright, Category=null, Groups=[homekit_gTW]) / Brightness

2021-01-18 21:49:56.181 [TRACE] [impl.connections.SubscriptionManager] - Added subscription to class io.github.hapjava.characteristics.impl.lightbulb.BrightnessCharacteristic for 15886536

2021-01-18 21:49:56.183 [TRACE] [er.impl.http.HomekitClientConnection] - 204 /characteristics

2021-01-18 21:49:56.187 [TRACE] [server.impl.http.impl.LoggingHandler] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 105, cap: 256) [/192.168.2.171:51002]:

5700410C5D9EE50D165B9447E155A5025F0A6F4FA8E6322F6A2516BBBAC50A7E27565D7C75E32BED1566C3A4DA2E15A353DFC76F7BFE55357AD4698ED92AE1F924C8D28D09105F93DF29BF924A729C17CBA94827180EF13FA631246F072F14D7CBFB58CEEC56C28A99

2021-01-18 21:49:56.200 [TRACE] [server.impl.http.impl.LoggingHandler] - READ PooledUnsafeDirectByteBuf(ridx: 0, widx: 98, cap: 496) [/192.168.2.171:51002]:

50001255B5530AB6A5B533C7D97E54AF16F1F8B7F74937263AF8D22B58E7A0AD65E0A06D2C3A9D0278665A66A45E76755549F9231BC12AD3D8EF54AE606C5CB78F8FFFF0B15A5CEC14C82FC333D81DFEED8B2B9F8F8BDDAB1DE5210BAFE4AAF67B97

2021-01-18 21:49:56.203 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Received message of length 98. Existing buffer is 0

2021-01-18 21:49:56.204 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Attempting to read message of length 98

2021-01-18 21:49:56.207 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Read complete message

2021-01-18 21:49:56.209 [TRACE] [ons.LengthPrefixedByteArrayProcessor] - Returning 1 results

2021-01-18 21:49:56.214 [TRACE] [er.impl.http.HomekitClientConnection] - 200 /characteristics?id=1538368759.7

2021-01-18 21:49:56.219 [TRACE] [server.impl.http.impl.LoggingHandler] - WRITE PooledUnsafeDirectByteBuf(ridx: 0, widx: 180, cap: 256) [/192.168.2.171:51002]:

A200EF12F030E46381D40A3D65D2184A075333891C73286A07B6600F0FE1BC7C095AC67C96EC3A1F08949CCD1BEE069227D5F88EB1F64EE09A47FDFCBA3D014F07B3AED2A1B9AA10A44B4931727D34C8A127A8682D25199DE568621E19418952901E3B58E3E26D628B04E1E103C1CF9A862E9FF07BBAEF784D77B3251A712601399157F821F6C3FBB9F55608CC97DDE2C55A15E6641390887C2B891521BBCDFCD373C734394B95FDC0C03544356C3B04566FD061