Skip to content

Instantly share code, notes, and snippets.

@redparchel
Created September 25, 2016 08:51
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save redparchel/3bfed9c250e8525c1f38954bbb5a2550 to your computer and use it in GitHub Desktop.
Save redparchel/3bfed9c250e8525c1f38954bbb5a2550 to your computer and use it in GitHub Desktop.
openhab log while troubleshooting souliss binding
2016-09-25 01:46:37.612 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:37.612 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:37.612 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:37.613 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:37.613 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:37.614 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:37.614 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:37.614 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:37.614 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:37.785 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:37.786 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:37.791 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:38.196 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_health = 255.0
2016-09-25 01:46:38.197 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:38.198 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_health = 255.0
2016-09-25 01:46:38.201 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:38.202 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3733 packets in memory
2016-09-25 01:46:38.205 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:38.206 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:38.207 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x21 - Packet: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Elementi rimanenti in lista: 3733
2016-09-25 01:46:38.208 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:38.209 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:38.210 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:38.211 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.216 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.217 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:38.218 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.220 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:38.221 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:38.222 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:38.222 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:38.223 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:38.224 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:38.224 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.228 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 00 18 01 28 E5 4F 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:38.229 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:38.229 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.230 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:38.231 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 0
2016-09-25 01:46:38.232 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_1_LH ( 153) = 2016-09-25T01:46:38.232PDT
2016-09-25 01:46:38.233 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:38.234 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 0. New State: 1.0
2016-09-25 01:46:38.235 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 1.0. RGB= 40, 229, 79
2016-09-25 01:46:38.236 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 2. New State: 229.0
2016-09-25 01:46:38.237 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 229.0. RGB= 79, 0, 0
2016-09-25 01:46:38.237 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.238 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:38.242 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 01 18 01 C9 CA FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:38.242 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.244 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:38.244 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:38.244 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 1
2016-09-25 01:46:38.246 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.247 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:38.247 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_2_LH ( 153) = 2016-09-25T01:46:38.246PDT
2016-09-25 01:46:38.249 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2, Typ: 0x16, Node: 1, Slot: 0. New State: 1.0
2016-09-25 01:46:38.250 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:38.250 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_2 (22) = 1.0. RGB= 201, 202, 255
2016-09-25 01:46:38.250 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:38.252 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:38.253 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:38.254 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:38.255 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:38.255 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:38.257 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:38.258 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:38.259 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:38.259 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:38.269 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:38.269 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:38.271 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:38.293 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.298 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.299 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:38.300 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.302 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.306 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.308 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:38.321 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.326 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.328 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:38.329 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:38.330 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:38.331 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:38.333 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:38.334 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:38.335 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:38.335 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:38.336 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:38.337 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:38.338 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:38.339 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:38.340 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:38.350 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:38.350 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:38.350 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:39.227 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 1.0, R=40, G=229, B=79
2016-09-25 01:46:39.229 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2 = 1.0, R=201, G=202, B=255
2016-09-25 01:46:39.246 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_LH = 2016-09-25T01:46:38.246PDT
2016-09-25 01:46:39.249 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_LH = 2016-09-25T01:46:38.246PDT
2016-09-25 01:46:39.252 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 229.0, R=79, G=0, B=0
2016-09-25 01:46:39.253 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3734 packets in memory
2016-09-25 01:46:39.254 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:39.256 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:39.257 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x25 - Packet: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Elementi rimanenti in lista: 3734
2016-09-25 01:46:39.258 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:39.259 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:39.260 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:39.261 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:39.262 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:39.263 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:39.263 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:39.264 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:39.270 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:39.273 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.278 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.280 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [0E 0D 17 86 47 A0 00 35 00 00 00 02 FF F3 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:39.281 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x35
2016-09-25 01:46:39.282 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - function_health_resp
2016-09-25 01:46:39.283 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:39.283 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 0; Value: 255
2016-09-25 01:46:39.284 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1_health, Typ: 0x98, Node: 0, Slot: 998. New State: 255.0
2016-09-25 01:46:39.285 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_1_health ( 152) = 255
2016-09-25 01:46:39.286 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 1; Value: 243
2016-09-25 01:46:39.287 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2_health, Typ: 0x98, Node: 1, Slot: 998. New State: 243.0
2016-09-25 01:46:39.288 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_2_health ( 152) = 243
2016-09-25 01:46:39.289 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.292 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.295 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.297 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:39.299 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.304 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.306 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.306 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:39.308 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:39.309 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:39.311 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:39.312 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:39.312 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:39.313 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:39.313 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:39.315 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:39.316 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:39.316 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:39.317 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:39.352 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.356 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.357 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:39.358 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.360 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.363 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.364 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:39.367 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.372 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.373 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:39.374 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:39.375 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:39.376 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:39.378 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:39.378 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:39.378 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:39.378 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:39.378 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:39.380 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:39.380 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:39.380 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:39.380 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:39.490 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:39.490 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:39.491 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:39.491 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:39.491 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:39.491 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:40.266 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_health = 243.0
2016-09-25 01:46:40.267 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xF3 -> null
2016-09-25 01:46:40.268 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_health = 255.0
2016-09-25 01:46:40.269 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:40.271 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3735 packets in memory
2016-09-25 01:46:40.272 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:40.273 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:40.274 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x21 - Packet: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Elementi rimanenti in lista: 3735
2016-09-25 01:46:40.275 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:40.276 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:40.277 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:40.278 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:40.279 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:40.280 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:40.280 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:40.281 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:40.293 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:40.296 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 00 18 01 28 E5 4F 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:40.297 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:40.298 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:40.299 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 0
2016-09-25 01:46:40.301 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_1_LH ( 153) = 2016-09-25T01:46:40.301PDT
2016-09-25 01:46:40.302 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 0. New State: 1.0
2016-09-25 01:46:40.303 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 1.0. RGB= 40, 229, 79
2016-09-25 01:46:40.304 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 2. New State: 229.0
2016-09-25 01:46:40.304 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 229.0. RGB= 79, 0, 0
2016-09-25 01:46:40.493 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.493 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.498 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.498 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.499 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:40.499 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.500 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:40.501 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.502 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.504 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.506 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.508 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:40.508 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.510 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.510 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:40.512 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.516 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.517 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.518 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:40.519 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.520 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:40.520 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:40.521 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:40.522 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:40.522 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:40.523 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:40.523 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:40.523 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:40.524 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:40.525 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:40.525 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:40.526 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:40.526 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:40.526 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:40.527 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:40.529 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:40.530 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:40.530 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:40.531 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:40.532 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:40.534 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:40.534 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:40.535 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:40.535 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:40.545 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:40.545 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:40.546 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:40.862 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:40.863 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:40.863 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:41.284 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 1.0, R=40, G=229, B=79
2016-09-25 01:46:41.285 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_LH = 2016-09-25T01:46:40.301PDT
2016-09-25 01:46:41.288 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 229.0, R=79, G=0, B=0
2016-09-25 01:46:41.289 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3736 packets in memory
2016-09-25 01:46:41.290 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:41.292 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:41.293 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x25 - Packet: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Elementi rimanenti in lista: 3736
2016-09-25 01:46:41.294 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:41.295 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:41.296 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:41.297 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:41.298 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:41.298 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:41.299 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:41.300 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:41.333 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:41.337 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [0E 0D 17 86 47 A0 00 35 00 00 00 02 FF FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:41.338 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x35
2016-09-25 01:46:41.339 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - function_health_resp
2016-09-25 01:46:41.339 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 0; Value: 255
2016-09-25 01:46:41.340 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1_health, Typ: 0x98, Node: 0, Slot: 998. New State: 255.0
2016-09-25 01:46:41.340 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_1_health ( 152) = 255
2016-09-25 01:46:41.341 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 1; Value: 255
2016-09-25 01:46:41.342 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2_health, Typ: 0x98, Node: 1, Slot: 998. New State: 255.0
2016-09-25 01:46:41.342 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_2_health ( 152) = 255
2016-09-25 01:46:41.547 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:41.553 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:41.554 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:41.554 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:41.556 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:41.560 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:41.562 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:41.564 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:41.569 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:41.571 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:41.571 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:41.573 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:41.573 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:41.575 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:41.576 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:41.576 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:41.576 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:41.577 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:41.578 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:41.579 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:41.579 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:41.580 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:41.791 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:41.794 [INFO ] [.o.b.s.internal.SoulissBinding] - receiveCommand - RGB_LytBulb_1 = 117.96610169491527,74.68354430379746,30.980392156862745 - Typical: 0x16
2016-09-25 01:46:41.795 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate commands: HSBType -> 0x22
2016-09-25 01:46:41.796 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:41.796 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendFORCEFrame - HEX: [33 00 00 00 04 22 15 4F 13 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:41.796 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:41.797 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:41.798 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:41.803 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 15 4F 13 ]
2016-09-25 01:46:42.302 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_health = 255.0
2016-09-25 01:46:42.303 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:42.304 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_health = 255.0
2016-09-25 01:46:42.305 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:42.306 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3738 packets in memory
2016-09-25 01:46:42.307 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:42.308 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:42.310 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x21 - Packet: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Elementi rimanenti in lista: 3738
2016-09-25 01:46:42.311 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:42.312 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:42.313 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:42.314 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:42.315 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:42.315 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:42.316 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:42.316 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:42.317 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:42.320 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 01 18 01 C9 CA FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:42.320 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:42.321 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:42.321 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 1
2016-09-25 01:46:42.322 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_2_LH ( 153) = 2016-09-25T01:46:42.322PDT
2016-09-25 01:46:42.323 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2, Typ: 0x16, Node: 1, Slot: 0. New State: 1.0
2016-09-25 01:46:42.324 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_2 (22) = 1.0. RGB= 201, 202, 255
2016-09-25 01:46:42.325 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:42.331 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 00 18 01 28 E5 4F 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:42.332 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:42.333 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:42.333 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 0
2016-09-25 01:46:42.334 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_1_LH ( 153) = 2016-09-25T01:46:42.334PDT
2016-09-25 01:46:42.335 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 0. New State: 1.0
2016-09-25 01:46:42.336 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 1.0. RGB= 40, 229, 79
2016-09-25 01:46:42.337 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 2. New State: 229.0
2016-09-25 01:46:42.338 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 229.0. RGB= 79, 0, 0
2016-09-25 01:46:42.800 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:42.805 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:42.806 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:42.807 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:42.809 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:42.813 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:42.815 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:42.817 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:42.823 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:42.824 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:42.825 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:42.827 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:42.828 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:42.830 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:42.831 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:42.831 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:42.831 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:42.832 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:42.834 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:42.834 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:42.835 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:42.836 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:42.846 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:42.847 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:42.848 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:43.320 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 1.0, R=40, G=229, B=79
2016-09-25 01:46:43.321 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2 = 1.0, R=201, G=202, B=255
2016-09-25 01:46:43.322 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_LH = 2016-09-25T01:46:42.334PDT
2016-09-25 01:46:43.324 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_LH = 2016-09-25T01:46:42.334PDT
2016-09-25 01:46:43.328 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 229.0, R=79, G=0, B=0
2016-09-25 01:46:43.331 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3739 packets in memory
2016-09-25 01:46:43.332 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:43.333 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:43.334 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x25 - Packet: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Elementi rimanenti in lista: 3739
2016-09-25 01:46:43.335 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:43.336 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:43.338 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:43.339 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:43.340 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:43.341 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:43.342 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:43.343 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:43.347 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:43.350 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [0E 0D 17 86 47 A0 00 35 00 00 00 02 FF F3 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:43.352 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.352 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x35
2016-09-25 01:46:43.358 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.359 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - function_health_resp
2016-09-25 01:46:43.360 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:43.361 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 0; Value: 255
2016-09-25 01:46:43.362 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1_health, Typ: 0x98, Node: 0, Slot: 998. New State: 255.0
2016-09-25 01:46:43.362 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_1_health ( 152) = 255
2016-09-25 01:46:43.363 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 1; Value: 243
2016-09-25 01:46:43.364 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2_health, Typ: 0x98, Node: 1, Slot: 998. New State: 243.0
2016-09-25 01:46:43.364 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_2_health ( 152) = 243
2016-09-25 01:46:43.365 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.368 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.371 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.374 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:43.376 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.380 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.382 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.383 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:43.384 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:43.385 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:43.387 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:43.388 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:43.388 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:43.389 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:43.389 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:43.391 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:43.392 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:43.392 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:43.393 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:43.442 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:43.445 [INFO ] [.o.b.s.internal.SoulissBinding] - receiveCommand - RGB_LytBulb_1 = 239.0769230769231,82.27848101265823,30.980392156862745 - Typical: 0x16
2016-09-25 01:46:43.446 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate commands: HSBType -> 0x22
2016-09-25 01:46:43.447 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendFORCEFrame - HEX: [33 00 00 00 04 22 0E 0F 4F ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:43.448 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:43.450 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:43.450 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:43.450 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:43.452 [DEBUG] [s.i.network.udp.SendDispatcher] - Frame UPD per nodo 0 già presente il lista. Esecuzione ottimizzazione.
2016-09-25 01:46:43.453 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Packet to push: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 0E 0F 4F ]
2016-09-25 01:46:43.456 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 15 4F 13 ]
2016-09-25 01:46:43.457 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame modified to: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 0E 0F 4F ]
2016-09-25 01:46:43.942 [DEBUG] [.o.b.nest.internal.NestBinding] - We received this event (item='hallway_humidity', state='55') from Nest, so we don't send it back again -> ignore!
2016-09-25 01:46:43.945 [DEBUG] [.o.b.nest.internal.NestBinding] - We received this event (item='hallway_last_connection', state='2016-09-25T01:28:00') from Nest, so we don't send it back again -> ignore!
2016-09-25 01:46:43.948 [DEBUG] [.o.b.nest.internal.NestBinding] - We received this event (item='hallway_hvac_mode', state='heat') from Nest, so we don't send it back again -> ignore!
2016-09-25 01:46:43.950 [DEBUG] [.o.b.nest.internal.NestBinding] - We received this event (item='hallway_target_temperature_high_f', state='75') from Nest, so we don't send it back again -> ignore!
2016-09-25 01:46:43.952 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.958 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.959 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:43.960 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.963 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.964 [DEBUG] [.o.b.nest.internal.NestBinding] - We received this event (item='hallway_temperature_scale', state='F') from Nest, so we don't send it back again -> ignore!
2016-09-25 01:46:43.966 [DEBUG] [.o.b.nest.internal.NestBinding] - We received this event (item='hallway_away_temperature_low_f', state='58') from Nest, so we don't send it back again -> ignore!
2016-09-25 01:46:43.970 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.972 [DEBUG] [.o.b.nest.internal.NestBinding] - We received this event (item='hallway_away_temperature_high_f', state='76') from Nest, so we don't send it back again -> ignore!
2016-09-25 01:46:43.975 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:43.975 [DEBUG] [.o.b.nest.internal.NestBinding] - We received this event (item='hallway_target_temperature_f', state='60') from Nest, so we don't send it back again -> ignore!
2016-09-25 01:46:43.980 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.980 [DEBUG] [.o.b.nest.internal.NestBinding] - We received this event (item='hallway_target_temperature_low_f', state='68') from Nest, so we don't send it back again -> ignore!
2016-09-25 01:46:43.984 [DEBUG] [.o.b.nest.internal.NestBinding] - We received this event (item='home_away', state='home') from Nest, so we don't send it back again -> ignore!
2016-09-25 01:46:43.988 [DEBUG] [.o.b.nest.internal.NestBinding] - We received this event (item='hallway_ambient_temperature_c', state='20.5') from Nest, so we don't send it back again -> ignore!
2016-09-25 01:46:43.992 [DEBUG] [.o.b.nest.internal.NestBinding] - We received this event (item='hallway_ambient_temperature_f', state='69') from Nest, so we don't send it back again -> ignore!
2016-09-25 01:46:43.993 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.996 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:43.997 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:44.010 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:44.011 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:44.013 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:44.013 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:44.013 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:44.014 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:44.014 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:44.016 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:44.016 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:44.017 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:44.017 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:44.346 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_health = 243.0
2016-09-25 01:46:44.346 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xF3 -> null
2016-09-25 01:46:44.347 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_health = 255.0
2016-09-25 01:46:44.347 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:44.347 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3740 packets in memory
2016-09-25 01:46:44.348 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:44.348 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:44.349 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x21 - Packet: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Elementi rimanenti in lista: 3740
2016-09-25 01:46:44.349 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:44.350 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:44.350 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:44.350 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:44.350 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:44.350 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:44.350 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:44.351 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:44.367 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:44.371 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 00 18 01 28 E5 4F 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:44.371 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:44.372 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:44.372 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 0
2016-09-25 01:46:44.373 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_1_LH ( 153) = 2016-09-25T01:46:44.373PDT
2016-09-25 01:46:44.374 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 0. New State: 1.0
2016-09-25 01:46:44.375 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 1.0. RGB= 40, 229, 79
2016-09-25 01:46:44.376 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 2. New State: 229.0
2016-09-25 01:46:44.376 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 229.0. RGB= 79, 0, 0
2016-09-25 01:46:44.540 [DEBUG] [.o.m.c.i.folder.FolderObserver] - Refreshing folder 'sitemaps'
2016-09-25 01:46:44.542 [DEBUG] [.o.m.c.i.folder.FolderObserver] - Refreshing folder 'persistence'
2016-09-25 01:46:44.544 [DEBUG] [.o.m.c.i.folder.FolderObserver] - Refreshing folder 'rules'
2016-09-25 01:46:44.546 [DEBUG] [.o.m.c.i.folder.FolderObserver] - Refreshing folder 'scripts'
2016-09-25 01:46:44.548 [DEBUG] [.o.m.c.i.folder.FolderObserver] - Refreshing folder 'items'
2016-09-25 01:46:44.782 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:44.783 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:44.784 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:44.874 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:44.877 [INFO ] [.o.b.s.internal.SoulissBinding] - receiveCommand - RGB_LytBulb_1 = 354.70588235294116,86.07594936708861,30.980392156862745 - Typical: 0x16
2016-09-25 01:46:44.878 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate commands: HSBType -> 0x22
2016-09-25 01:46:44.880 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendFORCEFrame - HEX: [33 00 00 00 04 22 4F 0B 11 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:44.881 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:44.884 [DEBUG] [s.i.network.udp.SendDispatcher] - Frame UPD per nodo 0 già presente il lista. Esecuzione ottimizzazione.
2016-09-25 01:46:44.885 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Packet to push: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 4F 0B 11 ]
2016-09-25 01:46:44.887 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 0E 0F 4F ]
2016-09-25 01:46:44.889 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame modified to: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 4F 0B 11 ]
2016-09-25 01:46:45.352 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 1.0, R=40, G=229, B=79
2016-09-25 01:46:45.354 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_LH = 2016-09-25T01:46:44.373PDT
2016-09-25 01:46:45.358 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 229.0, R=79, G=0, B=0
2016-09-25 01:46:45.360 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3741 packets in memory
2016-09-25 01:46:45.363 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:45.364 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:45.367 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x25 - Packet: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Elementi rimanenti in lista: 3741
2016-09-25 01:46:45.368 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:45.370 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:45.371 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:45.373 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:45.374 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:45.376 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:45.377 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:45.379 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:45.381 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:45.385 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [0E 0D 17 86 47 A0 00 35 00 00 00 02 FF F3 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:45.391 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x35
2016-09-25 01:46:45.392 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - function_health_resp
2016-09-25 01:46:45.393 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 0; Value: 255
2016-09-25 01:46:45.395 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1_health, Typ: 0x98, Node: 0, Slot: 998. New State: 255.0
2016-09-25 01:46:45.396 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_1_health ( 152) = 255
2016-09-25 01:46:45.397 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 1; Value: 243
2016-09-25 01:46:45.399 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2_health, Typ: 0x98, Node: 1, Slot: 998. New State: 243.0
2016-09-25 01:46:45.400 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_2_health ( 152) = 243
2016-09-25 01:46:45.493 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:45.497 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 01 18 01 C9 CA FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:45.503 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:45.504 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:45.505 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 1
2016-09-25 01:46:45.507 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_2_LH ( 153) = 2016-09-25T01:46:45.507PDT
2016-09-25 01:46:45.508 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2, Typ: 0x16, Node: 1, Slot: 0. New State: 1.0
2016-09-25 01:46:45.509 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_2 (22) = 1.0. RGB= 201, 202, 255
2016-09-25 01:46:45.786 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:45.791 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:45.792 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:45.793 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:45.796 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:45.799 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:45.801 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:45.804 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:45.809 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:45.811 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:45.812 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:45.814 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:45.814 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:45.816 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:45.817 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:45.818 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:45.818 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:45.818 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:45.820 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:45.821 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:45.822 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:45.822 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:45.831 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:45.832 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:45.833 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:46.382 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2 = 1.0, R=201, G=202, B=255
2016-09-25 01:46:46.382 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_health = 243.0
2016-09-25 01:46:46.383 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xF3 -> null
2016-09-25 01:46:46.383 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_LH = 2016-09-25T01:46:45.507PDT
2016-09-25 01:46:46.385 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_health = 255.0
2016-09-25 01:46:46.385 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:46.385 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3742 packets in memory
2016-09-25 01:46:46.386 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:46.386 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:46.387 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x21 - Packet: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Elementi rimanenti in lista: 3742
2016-09-25 01:46:46.387 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:46.388 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:46.388 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:46.388 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:46.388 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:46.389 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:46.389 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:46.389 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:46.399 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:46.402 [INFO ] [.o.b.s.internal.SoulissBinding] - receiveCommand - RGB_LytBulb_1 = 354.97536945812806,85.65400843881856,92.94117647058823 - Typical: 0x16
2016-09-25 01:46:46.404 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate commands: HSBType -> 0x22
2016-09-25 01:46:46.405 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendFORCEFrame - HEX: [33 00 00 00 04 22 ED 22 33 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:46.406 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:46.407 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:46.408 [DEBUG] [s.i.network.udp.SendDispatcher] - Frame UPD per nodo 0 già presente il lista. Esecuzione ottimizzazione.
2016-09-25 01:46:46.409 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Packet to push: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 ED 22 33 ]
2016-09-25 01:46:46.409 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 4F 0B 11 ]
2016-09-25 01:46:46.410 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame modified to: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 ED 22 33 ]
2016-09-25 01:46:46.410 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 00 18 01 28 E5 4F 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:46.410 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:46.410 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:46.410 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 0
2016-09-25 01:46:46.411 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_1_LH ( 153) = 2016-09-25T01:46:46.411PDT
2016-09-25 01:46:46.411 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 0. New State: 1.0
2016-09-25 01:46:46.411 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 1.0. RGB= 40, 229, 79
2016-09-25 01:46:46.411 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 2. New State: 229.0
2016-09-25 01:46:46.427 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 229.0. RGB= 79, 0, 0
2016-09-25 01:46:46.835 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:46.840 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:46.841 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:46.842 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:46.844 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:46.847 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:46.849 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:46.851 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:46.857 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:46.858 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:46.859 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:46.861 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:46.861 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:46.863 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:46.863 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:46.864 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:46.864 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:46.864 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:46.866 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:46.866 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:46.866 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:46.867 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:47.391 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 1.0, R=40, G=229, B=79
2016-09-25 01:46:47.392 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_LH = 2016-09-25T01:46:46.411PDT
2016-09-25 01:46:47.394 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 229.0, R=79, G=0, B=0
2016-09-25 01:46:47.394 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3743 packets in memory
2016-09-25 01:46:47.395 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:47.395 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:47.395 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x25 - Packet: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Elementi rimanenti in lista: 3743
2016-09-25 01:46:47.396 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:47.396 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:47.396 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:47.397 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:47.397 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:47.397 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:47.397 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:47.397 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:47.410 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:47.414 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [0E 0D 17 86 47 A0 00 35 00 00 00 02 FF FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:47.414 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x35
2016-09-25 01:46:47.414 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - function_health_resp
2016-09-25 01:46:47.414 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 0; Value: 255
2016-09-25 01:46:47.414 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1_health, Typ: 0x98, Node: 0, Slot: 998. New State: 255.0
2016-09-25 01:46:47.414 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_1_health ( 152) = 255
2016-09-25 01:46:47.415 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 1; Value: 255
2016-09-25 01:46:47.415 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2_health, Typ: 0x98, Node: 1, Slot: 998. New State: 255.0
2016-09-25 01:46:47.415 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_2_health ( 152) = 255
2016-09-25 01:46:47.483 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:47.485 [INFO ] [.o.b.s.internal.SoulissBinding] - receiveCommand - RGB_LytBulb_1 = 132.0618556701031,81.85654008438819,92.94117647058823 - Typical: 0x16
2016-09-25 01:46:47.485 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate commands: HSBType -> 0x22
2016-09-25 01:46:47.486 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendFORCEFrame - HEX: [33 00 00 00 04 22 2B ED 52 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:47.486 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:47.487 [DEBUG] [s.i.network.udp.SendDispatcher] - Frame UPD per nodo 0 già presente il lista. Esecuzione ottimizzazione.
2016-09-25 01:46:47.488 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Packet to push: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 2B ED 52 ]
2016-09-25 01:46:47.488 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 ED 22 33 ]
2016-09-25 01:46:47.488 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame modified to: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 2B ED 52 ]
2016-09-25 01:46:47.502 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:47.502 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:47.502 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:48.399 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_health = 255.0
2016-09-25 01:46:48.401 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:48.402 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_health = 255.0
2016-09-25 01:46:48.404 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:48.405 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3744 packets in memory
2016-09-25 01:46:48.407 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:48.407 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:48.408 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x21 - Packet: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Elementi rimanenti in lista: 3744
2016-09-25 01:46:48.408 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:48.409 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:48.409 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:48.409 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:48.409 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:48.410 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:48.410 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:48.410 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:48.445 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:48.449 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 00 18 01 28 E5 4F 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:48.455 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:48.456 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:48.458 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:48.461 [INFO ] [.o.b.s.internal.SoulissBinding] - receiveCommand - RGB_LytBulb_1 = 241.0404624277457,72.9957805907173,92.94117647058823 - Typical: 0x16
2016-09-25 01:46:48.463 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate commands: HSBType -> 0x22
2016-09-25 01:46:48.464 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendFORCEFrame - HEX: [33 00 00 00 04 22 43 3F ED ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:48.465 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:48.468 [DEBUG] [s.i.network.udp.SendDispatcher] - Frame UPD per nodo 0 già presente il lista. Esecuzione ottimizzazione.
2016-09-25 01:46:48.469 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 0
2016-09-25 01:46:48.470 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Packet to push: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 43 3F ED ]
2016-09-25 01:46:48.471 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 2B ED 52 ]
2016-09-25 01:46:48.473 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame modified to: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 43 3F ED ]
2016-09-25 01:46:48.478 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_1_LH ( 153) = 2016-09-25T01:46:48.478PDT
2016-09-25 01:46:48.479 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 0. New State: 1.0
2016-09-25 01:46:48.481 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 1.0. RGB= 40, 229, 79
2016-09-25 01:46:48.482 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 2. New State: 229.0
2016-09-25 01:46:48.483 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 229.0. RGB= 79, 0, 0
2016-09-25 01:46:48.504 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:48.509 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:48.510 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:48.511 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:48.514 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:48.517 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:48.519 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:48.521 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:48.526 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:48.528 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:48.529 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:48.531 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:48.531 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:48.533 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:48.534 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:48.534 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:48.534 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:48.535 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:48.536 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:48.537 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:48.537 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:48.538 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:48.549 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:48.549 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:48.549 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:49.189 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:49.191 [INFO ] [.o.b.s.internal.SoulissBinding] - receiveCommand - RGB_LytBulb_1 = 241.20805369127518,73.0392156862745,80 - Typical: 0x16
2016-09-25 01:46:49.192 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate commands: HSBType -> 0x22
2016-09-25 01:46:49.192 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendFORCEFrame - HEX: [33 00 00 00 04 22 39 37 CC ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:49.193 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:49.195 [DEBUG] [s.i.network.udp.SendDispatcher] - Frame UPD per nodo 0 già presente il lista. Esecuzione ottimizzazione.
2016-09-25 01:46:49.196 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Packet to push: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 39 37 CC ]
2016-09-25 01:46:49.196 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 43 3F ED ]
2016-09-25 01:46:49.197 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame modified to: HEX: [10 0F 17 A0 00 86 47 33 00 00 00 04 22 39 37 CC ]
2016-09-25 01:46:49.427 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 1.0, R=40, G=229, B=79
2016-09-25 01:46:49.428 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_LH = 2016-09-25T01:46:48.478PDT
2016-09-25 01:46:49.440 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 229.0, R=79, G=0, B=0
2016-09-25 01:46:49.440 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3745 packets in memory
2016-09-25 01:46:49.441 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:49.441 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:49.441 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x25 - Packet: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Elementi rimanenti in lista: 3745
2016-09-25 01:46:49.442 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:49.442 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:49.443 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:49.443 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:49.443 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:49.443 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:49.443 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:49.444 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:49.456 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:49.458 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [0E 0D 17 86 47 A0 00 35 00 00 00 02 FF FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:49.459 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x35
2016-09-25 01:46:49.459 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - function_health_resp
2016-09-25 01:46:49.459 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 0; Value: 255
2016-09-25 01:46:49.459 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1_health, Typ: 0x98, Node: 0, Slot: 998. New State: 255.0
2016-09-25 01:46:49.459 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_1_health ( 152) = 255
2016-09-25 01:46:49.459 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 1; Value: 255
2016-09-25 01:46:49.460 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2_health, Typ: 0x98, Node: 1, Slot: 998. New State: 255.0
2016-09-25 01:46:49.460 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_2_health ( 152) = 255
2016-09-25 01:46:49.551 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:49.555 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:49.556 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:49.556 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:49.561 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:49.565 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:49.567 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:49.570 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:49.575 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:49.577 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:49.579 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:49.581 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:49.582 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:49.585 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:49.586 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:49.588 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:49.589 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:49.590 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:49.592 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:49.594 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:49.595 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:49.596 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:49.683 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:49.687 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 01 18 01 C9 CA FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:49.692 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:49.693 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:49.694 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 1
2016-09-25 01:46:49.696 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_2_LH ( 153) = 2016-09-25T01:46:49.696PDT
2016-09-25 01:46:49.697 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2, Typ: 0x16, Node: 1, Slot: 0. New State: 1.0
2016-09-25 01:46:49.699 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_2 (22) = 1.0. RGB= 201, 202, 255
2016-09-25 01:46:50.447 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2 = 1.0, R=201, G=202, B=255
2016-09-25 01:46:50.448 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_health = 255.0
2016-09-25 01:46:50.450 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:50.452 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_LH = 2016-09-25T01:46:49.696PDT
2016-09-25 01:46:50.457 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_health = 255.0
2016-09-25 01:46:50.458 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:50.460 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3746 packets in memory
2016-09-25 01:46:50.462 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:50.465 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:50.466 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x21 - Packet: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Elementi rimanenti in lista: 3746
2016-09-25 01:46:50.468 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:50.469 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:50.471 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:50.472 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:50.473 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:50.475 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:50.476 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:50.477 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:50.483 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:50.487 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 00 18 01 28 E5 4F 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:50.492 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:50.494 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:50.495 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 0
2016-09-25 01:46:50.496 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_1_LH ( 153) = 2016-09-25T01:46:50.496PDT
2016-09-25 01:46:50.498 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 0. New State: 1.0
2016-09-25 01:46:50.499 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 1.0. RGB= 40, 229, 79
2016-09-25 01:46:50.500 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 2. New State: 229.0
2016-09-25 01:46:50.502 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 229.0. RGB= 79, 0, 0
2016-09-25 01:46:50.877 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:50.878 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:50.878 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:50.888 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:50.888 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:50.888 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:51.481 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 1.0, R=40, G=229, B=79
2016-09-25 01:46:51.482 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_LH = 2016-09-25T01:46:50.496PDT
2016-09-25 01:46:51.484 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 229.0, R=79, G=0, B=0
2016-09-25 01:46:51.485 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3747 packets in memory
2016-09-25 01:46:51.485 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:51.486 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:51.486 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x25 - Packet: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Elementi rimanenti in lista: 3747
2016-09-25 01:46:51.486 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:51.495 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:51.496 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:51.498 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:51.502 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [0E 0D 17 86 47 A0 00 35 00 00 00 02 FF F3 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:51.507 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x35
2016-09-25 01:46:51.508 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - function_health_resp
2016-09-25 01:46:51.509 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 0; Value: 255
2016-09-25 01:46:51.511 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1_health, Typ: 0x98, Node: 0, Slot: 998. New State: 255.0
2016-09-25 01:46:51.512 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_1_health ( 152) = 255
2016-09-25 01:46:51.513 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 1; Value: 243
2016-09-25 01:46:51.514 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:51.515 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2_health, Typ: 0x98, Node: 1, Slot: 998. New State: 243.0
2016-09-25 01:46:51.516 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_2_health ( 152) = 243
2016-09-25 01:46:51.517 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:51.518 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:51.518 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:51.518 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:51.880 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.885 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.886 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:51.887 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.890 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.895 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.897 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:51.898 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.900 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.905 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.909 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.912 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.914 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:51.916 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:51.918 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.920 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.924 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.929 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.931 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.932 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:51.933 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:51.934 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:51.935 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:51.935 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:51.938 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:51.939 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:51.940 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:51.941 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:51.942 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:51.942 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:51.943 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:51.943 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:51.944 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:51.945 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:51.942 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:51.946 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:51.947 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:51.947 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:51.948 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:51.948 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:51.950 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:51.954 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:51.954 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:51.955 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:52.520 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_health = 243.0
2016-09-25 01:46:52.521 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xF3 -> null
2016-09-25 01:46:52.521 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_health = 255.0
2016-09-25 01:46:52.521 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:52.521 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3748 packets in memory
2016-09-25 01:46:52.522 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:52.522 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:52.523 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x21 - Packet: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Elementi rimanenti in lista: 3748
2016-09-25 01:46:52.523 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:52.524 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:52.524 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:52.524 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:52.524 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:52.525 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:52.525 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:52.525 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:52.539 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:52.543 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 00 18 01 28 E5 4F 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:52.543 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:52.543 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:52.543 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 0
2016-09-25 01:46:52.544 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_1_LH ( 153) = 2016-09-25T01:46:52.544PDT
2016-09-25 01:46:52.544 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 0. New State: 1.0
2016-09-25 01:46:52.544 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 1.0. RGB= 40, 229, 79
2016-09-25 01:46:52.544 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 2. New State: 229.0
2016-09-25 01:46:52.544 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 229.0. RGB= 79, 0, 0
2016-09-25 01:46:52.886 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:52.886 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:52.886 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:52.908 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:52.908 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:52.909 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:53.527 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 1.0, R=40, G=229, B=79
2016-09-25 01:46:53.528 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_LH = 2016-09-25T01:46:52.544PDT
2016-09-25 01:46:53.530 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 229.0, R=79, G=0, B=0
2016-09-25 01:46:53.530 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3749 packets in memory
2016-09-25 01:46:53.531 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:53.531 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:53.532 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x25 - Packet: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Elementi rimanenti in lista: 3749
2016-09-25 01:46:53.532 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:53.533 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:53.533 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:53.534 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:53.534 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:53.534 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:53.534 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:53.535 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:53.549 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:53.552 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [0E 0D 17 86 47 A0 00 35 00 00 00 02 FF FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:53.553 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x35
2016-09-25 01:46:53.553 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - function_health_resp
2016-09-25 01:46:53.567 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 0; Value: 255
2016-09-25 01:46:53.567 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1_health, Typ: 0x98, Node: 0, Slot: 998. New State: 255.0
2016-09-25 01:46:53.567 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_1_health ( 152) = 255
2016-09-25 01:46:53.567 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 1; Value: 255
2016-09-25 01:46:53.567 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2_health, Typ: 0x98, Node: 1, Slot: 998. New State: 255.0
2016-09-25 01:46:53.567 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_2_health ( 152) = 255
2016-09-25 01:46:53.714 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:53.715 [INFO ] [.o.b.s.internal.SoulissBinding] - receiveCommand - RGB_LytBulb_2 = 115.87155963302753,85.49019607843137,100 - Typical: 0x16
2016-09-25 01:46:53.716 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate commands: HSBType -> 0x22
2016-09-25 01:46:53.716 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendFORCEFrame - HEX: [33 00 00 01 04 22 33 FF 24 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:53.716 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:53.721 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 33 FF 24 ]
2016-09-25 01:46:53.781 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:53.785 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 01 18 01 C9 CA FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:53.791 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:53.792 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:53.793 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 1
2016-09-25 01:46:53.795 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_2_LH ( 153) = 2016-09-25T01:46:53.795PDT
2016-09-25 01:46:53.796 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2, Typ: 0x16, Node: 1, Slot: 0. New State: 1.0
2016-09-25 01:46:53.797 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_2 (22) = 1.0. RGB= 201, 202, 255
2016-09-25 01:46:53.888 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:53.894 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:53.895 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:53.896 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:53.898 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:53.901 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:53.904 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:53.906 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:53.910 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:53.912 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:53.912 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:53.914 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:53.915 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:53.917 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:53.917 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:53.917 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:53.918 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:53.918 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:53.920 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:53.920 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:53.921 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:53.921 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:53.931 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:53.931 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:53.932 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:54.542 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2 = 1.0, R=201, G=202, B=255
2016-09-25 01:46:54.542 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_health = 255.0
2016-09-25 01:46:54.550 [DEBUG] [.o.m.c.i.folder.FolderObserver] - Refreshing folder 'sitemaps'
2016-09-25 01:46:54.553 [DEBUG] [.o.m.c.i.folder.FolderObserver] - Refreshing folder 'persistence'
2016-09-25 01:46:54.554 [DEBUG] [.o.m.c.i.folder.FolderObserver] - Refreshing folder 'rules'
2016-09-25 01:46:54.555 [DEBUG] [.o.m.c.i.folder.FolderObserver] - Refreshing folder 'scripts'
2016-09-25 01:46:54.555 [DEBUG] [.o.m.c.i.folder.FolderObserver] - Refreshing folder 'items'
2016-09-25 01:46:54.556 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:54.556 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_LH = 2016-09-25T01:46:53.795PDT
2016-09-25 01:46:54.558 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_health = 255.0
2016-09-25 01:46:54.558 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:54.559 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3751 packets in memory
2016-09-25 01:46:54.559 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:54.560 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:54.560 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x21 - Packet: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Elementi rimanenti in lista: 3751
2016-09-25 01:46:54.561 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:54.561 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:54.561 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:54.562 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:54.562 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:54.562 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:54.562 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:54.563 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:54.581 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:54.584 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 00 18 01 28 E5 4F 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:54.584 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:54.584 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:54.585 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 0
2016-09-25 01:46:54.585 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_1_LH ( 153) = 2016-09-25T01:46:54.585PDT
2016-09-25 01:46:54.585 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 0. New State: 1.0
2016-09-25 01:46:54.585 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 1.0. RGB= 40, 229, 79
2016-09-25 01:46:54.585 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 2. New State: 229.0
2016-09-25 01:46:54.586 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 229.0. RGB= 79, 0, 0
2016-09-25 01:46:54.633 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:54.634 [INFO ] [.o.b.s.internal.SoulissBinding] - receiveCommand - RGB_LytBulb_2 = 238.86792452830187,83.13725490196079,100 - Typical: 0x16
2016-09-25 01:46:54.635 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate commands: HSBType -> 0x22
2016-09-25 01:46:54.635 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendFORCEFrame - HEX: [33 00 00 01 04 22 2B 2F FF ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:54.635 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:54.640 [DEBUG] [s.i.network.udp.SendDispatcher] - Frame UPD per nodo 1 già presente il lista. Esecuzione ottimizzazione.
2016-09-25 01:46:54.642 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Packet to push: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 2B 2F FF ]
2016-09-25 01:46:54.643 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 33 FF 24 ]
2016-09-25 01:46:54.645 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame modified to: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 2B 2F FF ]
2016-09-25 01:46:54.934 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:54.939 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:54.940 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:54.941 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:54.943 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:54.946 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:54.948 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:54.951 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:54.955 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:54.957 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:54.958 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:54.959 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:54.960 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:54.962 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:54.962 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:54.962 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:54.962 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:54.963 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:54.964 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:54.965 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:54.965 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:54.965 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:55.570 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 1.0, R=40, G=229, B=79
2016-09-25 01:46:55.571 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_LH = 2016-09-25T01:46:54.585PDT
2016-09-25 01:46:55.573 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 229.0, R=79, G=0, B=0
2016-09-25 01:46:55.573 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3752 packets in memory
2016-09-25 01:46:55.574 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:55.574 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:55.575 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x25 - Packet: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Elementi rimanenti in lista: 3752
2016-09-25 01:46:55.575 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:55.575 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:55.576 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:55.576 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:55.576 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:55.576 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:55.576 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:55.588 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:55.592 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [0E 0D 17 86 47 A0 00 35 00 00 00 02 FF FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:55.592 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x35
2016-09-25 01:46:55.592 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - function_health_resp
2016-09-25 01:46:55.592 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 0; Value: 255
2016-09-25 01:46:55.592 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1_health, Typ: 0x98, Node: 0, Slot: 998. New State: 255.0
2016-09-25 01:46:55.592 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_1_health ( 152) = 255
2016-09-25 01:46:55.593 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 1; Value: 255
2016-09-25 01:46:55.593 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2_health, Typ: 0x98, Node: 1, Slot: 998. New State: 255.0
2016-09-25 01:46:55.593 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_2_health ( 152) = 255
2016-09-25 01:46:55.593 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:55.902 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:55.905 [INFO ] [.o.b.s.internal.SoulissBinding] - receiveCommand - RGB_LytBulb_2 = 351.98275862068965,90.98039215686275,100 - Typical: 0x16
2016-09-25 01:46:55.906 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate commands: HSBType -> 0x22
2016-09-25 01:46:55.908 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendFORCEFrame - HEX: [33 00 00 01 04 22 FF 16 36 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:55.909 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:55.909 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:55.909 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:55.910 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:55.912 [DEBUG] [s.i.network.udp.SendDispatcher] - Frame UPD per nodo 1 già presente il lista. Esecuzione ottimizzazione.
2016-09-25 01:46:55.913 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Packet to push: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 FF 16 36 ]
2016-09-25 01:46:55.915 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 2B 2F FF ]
2016-09-25 01:46:55.916 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame modified to: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 FF 16 36 ]
2016-09-25 01:46:56.595 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_health = 255.0
2016-09-25 01:46:56.595 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:56.596 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_health = 255.0
2016-09-25 01:46:56.596 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:56.596 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3753 packets in memory
2016-09-25 01:46:56.596 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:56.597 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:56.597 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x21 - Packet: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Elementi rimanenti in lista: 3753
2016-09-25 01:46:56.598 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:56.598 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:56.598 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:56.599 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:56.599 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:56.599 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:56.599 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:56.600 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:56.612 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:56.615 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 00 18 01 28 E5 4F 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:56.616 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:56.616 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:56.616 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 0
2016-09-25 01:46:56.616 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_1_LH ( 153) = 2016-09-25T01:46:56.616PDT
2016-09-25 01:46:56.616 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 0. New State: 1.0
2016-09-25 01:46:56.616 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 1.0. RGB= 40, 229, 79
2016-09-25 01:46:56.617 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 2. New State: 229.0
2016-09-25 01:46:56.617 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 229.0. RGB= 79, 0, 0
2016-09-25 01:46:56.850 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:56.853 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 01 18 01 C9 CA FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:56.853 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:56.853 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:56.853 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 1
2016-09-25 01:46:56.854 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_2_LH ( 153) = 2016-09-25T01:46:56.854PDT
2016-09-25 01:46:56.854 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2, Typ: 0x16, Node: 1, Slot: 0. New State: 1.0
2016-09-25 01:46:56.854 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_2 (22) = 1.0. RGB= 201, 202, 255
2016-09-25 01:46:56.910 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:56.916 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:56.916 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:56.919 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:56.922 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:56.926 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:56.929 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:56.931 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:56.937 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:56.939 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:56.940 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:56.943 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:56.944 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:56.946 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:56.948 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:56.949 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:56.950 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:56.951 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:56.954 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:56.955 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:56.956 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:56.958 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:56.963 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:56.966 [INFO ] [.o.b.s.internal.SoulissBinding] - receiveCommand - RGB_LytBulb_2 = 58.90909090909091,86.27450980392156,100 - Typical: 0x16
2016-09-25 01:46:56.968 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate commands: HSBType -> 0x22
2016-09-25 01:46:56.969 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendFORCEFrame - HEX: [33 00 00 01 04 22 FF FB 22 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:56.969 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:56.971 [DEBUG] [s.i.network.udp.SendDispatcher] - Frame UPD per nodo 1 già presente il lista. Esecuzione ottimizzazione.
2016-09-25 01:46:56.972 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Packet to push: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 FF FB 22 ]
2016-09-25 01:46:56.973 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 FF 16 36 ]
2016-09-25 01:46:56.974 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame modified to: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 FF FB 22 ]
2016-09-25 01:46:56.977 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:56.977 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:56.978 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:57.606 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 1.0, R=40, G=229, B=79
2016-09-25 01:46:57.607 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2 = 1.0, R=201, G=202, B=255
2016-09-25 01:46:57.608 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_LH = 2016-09-25T01:46:56.854PDT
2016-09-25 01:46:57.609 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_LH = 2016-09-25T01:46:56.854PDT
2016-09-25 01:46:57.611 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 229.0, R=79, G=0, B=0
2016-09-25 01:46:57.620 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3754 packets in memory
2016-09-25 01:46:57.622 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:57.625 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:57.627 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x25 - Packet: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Elementi rimanenti in lista: 3754
2016-09-25 01:46:57.629 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:57.631 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:57.632 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:57.634 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:57.635 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:57.636 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:57.638 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:57.640 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:57.648 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:57.653 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [0E 0D 17 86 47 A0 00 35 00 00 00 02 FF F3 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:57.658 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x35
2016-09-25 01:46:57.659 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - function_health_resp
2016-09-25 01:46:57.661 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 0; Value: 255
2016-09-25 01:46:57.662 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1_health, Typ: 0x98, Node: 0, Slot: 998. New State: 255.0
2016-09-25 01:46:57.663 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_1_health ( 152) = 255
2016-09-25 01:46:57.665 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 1; Value: 243
2016-09-25 01:46:57.666 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2_health, Typ: 0x98, Node: 1, Slot: 998. New State: 243.0
2016-09-25 01:46:57.668 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_2_health ( 152) = 243
2016-09-25 01:46:57.980 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:57.985 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:57.986 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:57.987 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:57.990 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:57.993 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:57.995 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:57.997 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:58.002 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:58.004 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:58.004 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:58.006 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:58.006 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:58.008 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:58.009 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:58.009 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:58.009 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:58.010 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:58.011 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:58.012 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:58.012 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:58.012 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:58.432 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:58.434 [INFO ] [.o.b.s.internal.SoulissBinding] - receiveCommand - RGB_LytBulb_2 = 17.142857142857142,2.7450980392156863,100 - Typical: 0x16
2016-09-25 01:46:58.434 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate commands: HSBType -> 0x22
2016-09-25 01:46:58.435 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendFORCEFrame - HEX: [33 00 00 01 04 22 FF FA F8 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:58.435 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:58.436 [DEBUG] [s.i.network.udp.SendDispatcher] - Frame UPD per nodo 1 già presente il lista. Esecuzione ottimizzazione.
2016-09-25 01:46:58.437 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Packet to push: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 FF FA F8 ]
2016-09-25 01:46:58.437 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 FF FB 22 ]
2016-09-25 01:46:58.438 [DEBUG] [s.i.network.udp.SendDispatcher] - Optimizer. Previous frame modified to: HEX: [10 0F 17 A0 00 86 47 33 00 00 01 04 22 FF FA F8 ]
2016-09-25 01:46:58.447 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:46:58.447 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:46:58.448 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:46:58.646 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_health = 243.0
2016-09-25 01:46:58.647 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xF3 -> null
2016-09-25 01:46:58.647 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_health = 255.0
2016-09-25 01:46:58.647 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:46:58.648 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3755 packets in memory
2016-09-25 01:46:58.648 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:58.648 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:58.649 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x21 - Packet: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Elementi rimanenti in lista: 3755
2016-09-25 01:46:58.649 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:58.650 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:58.650 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:58.650 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:58.650 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:58.651 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:58.651 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:58.651 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:58.665 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:58.669 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 00 18 01 28 E5 4F 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:58.674 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:46:58.674 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:46:58.674 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 0
2016-09-25 01:46:58.675 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_1_LH ( 153) = 2016-09-25T01:46:58.675PDT
2016-09-25 01:46:58.675 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 0. New State: 1.0
2016-09-25 01:46:58.675 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 1.0. RGB= 40, 229, 79
2016-09-25 01:46:58.675 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 2. New State: 229.0
2016-09-25 01:46:58.675 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 229.0. RGB= 79, 0, 0
2016-09-25 01:46:58.949 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:58.955 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:58.956 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:46:58.956 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:58.959 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:58.962 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:58.964 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:46:58.966 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:58.971 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:58.973 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:46:58.973 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:58.975 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:58.976 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:58.978 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:58.978 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:58.978 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:46:58.979 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:46:58.979 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:46:58.980 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:46:58.981 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:58.981 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:46:58.981 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:46:59.653 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 1.0, R=40, G=229, B=79
2016-09-25 01:46:59.654 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_LH = 2016-09-25T01:46:58.675PDT
2016-09-25 01:46:59.666 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 229.0, R=79, G=0, B=0
2016-09-25 01:46:59.666 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3756 packets in memory
2016-09-25 01:46:59.667 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:46:59.667 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:46:59.668 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x25 - Packet: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Elementi rimanenti in lista: 3756
2016-09-25 01:46:59.668 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:46:59.669 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:59.669 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:59.669 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:46:59.669 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:46:59.669 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:46:59.670 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:46:59.670 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:46:59.684 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:46:59.688 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [0E 0D 17 86 47 A0 00 35 00 00 00 02 FF FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:46:59.688 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x35
2016-09-25 01:46:59.688 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - function_health_resp
2016-09-25 01:46:59.688 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 0; Value: 255
2016-09-25 01:46:59.688 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1_health, Typ: 0x98, Node: 0, Slot: 998. New State: 255.0
2016-09-25 01:46:59.689 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_1_health ( 152) = 255
2016-09-25 01:46:59.689 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 1; Value: 255
2016-09-25 01:46:59.689 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2_health, Typ: 0x98, Node: 1, Slot: 998. New State: 255.0
2016-09-25 01:46:59.689 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_2_health ( 152) = 255
2016-09-25 01:47:00.003 [DEBUG] [.p.internal.PersistenceManager] - Item 'DemoSwitch' does not exist.
2016-09-25 01:47:00.009 [DEBUG] [.o.m.r.i.engine.ExecuteRuleJob] - Executing scheduled rule 'garageMotionSensorOff'
2016-09-25 01:47:00.018 [DEBUG] [.p.internal.PersistenceManager] - Item 'NoOfLights' does not exist.
2016-09-25 01:47:00.019 [DEBUG] [.p.internal.PersistenceManager] - Item 'Window_GF_Toilet' does not exist.
2016-09-25 01:47:00.020 [DEBUG] [.p.internal.PersistenceManager] - Item group 'Heating' does not exist.
2016-09-25 01:47:00.021 [DEBUG] [.p.internal.PersistenceManager] - Item group 'Temperature' does not exist.
2016-09-25 01:47:00.022 [DEBUG] [.p.internal.PersistenceManager] - Item group 'Weather_Chart' does not exist.
2016-09-25 01:47:00.589 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:47:00.589 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:47:00.590 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:47:00.672 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_health = 255.0
2016-09-25 01:47:00.673 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:47:00.675 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_health = 255.0
2016-09-25 01:47:00.676 [DEBUG] [.s.i.n.typicals.StateTraslator] - translate states: NumberItem_0x98_0xFF -> null
2016-09-25 01:47:00.678 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3757 packets in memory
2016-09-25 01:47:00.681 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:47:00.683 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:47:00.685 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x21 - Packet: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ] - Elementi rimanenti in lista: 3757
2016-09-25 01:47:00.686 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:47:00.688 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:47:00.689 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:47:00.691 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:47:00.692 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:47:00.694 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:47:00.695 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:47:00.697 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:47:00.709 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:47:00.717 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 00 18 01 28 E5 4F 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:47:00.723 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:47:00.724 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:47:00.725 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 0
2016-09-25 01:47:00.727 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_1_LH ( 153) = 2016-09-25T01:47:00.727PDT
2016-09-25 01:47:00.729 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 0. New State: 1.0
2016-09-25 01:47:00.730 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 1.0. RGB= 40, 229, 79
2016-09-25 01:47:00.732 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1, Typ: 0x16, Node: 0, Slot: 2. New State: 229.0
2016-09-25 01:47:00.733 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_1 (22) = 229.0. RGB= 79, 0, 0
2016-09-25 01:47:00.909 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:47:00.911 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:47:00.912 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:47:00.940 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:47:00.945 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [24 23 17 86 47 A0 00 31 00 00 01 18 01 C9 CA FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:47:00.950 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x31
2016-09-25 01:47:00.951 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - Souliss_UDP_function_subscribe_resp / Souliss_UDP_function_poll_resp
2016-09-25 01:47:00.953 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateTIMESTAMP. Node: 1
2016-09-25 01:47:00.955 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateTIMESTAMP: RGB_LytBulb_2_LH ( 153) = 2016-09-25T01:47:00.955PDT
2016-09-25 01:47:00.956 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2, Typ: 0x16, Node: 1, Slot: 0. New State: 1.0
2016-09-25 01:47:00.958 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeStateRequest: RGB_LytBulb_2 (22) = 1.0. RGB= 201, 202, 255
2016-09-25 01:47:01.092 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.097 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.098 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:47:01.099 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.102 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.105 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.107 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:47:01.109 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.114 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.116 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.117 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:47:01.119 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:47:01.119 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:47:01.121 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:47:01.122 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:47:01.122 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:47:01.123 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:47:01.123 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:47:01.125 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:47:01.125 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:47:01.126 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:47:01.126 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:47:01.140 [DEBUG] [.io.net.http.SecureHttpContext] - security is disabled - processing aborted!
2016-09-25 01:47:01.140 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - Servlet request received!
2016-09-25 01:47:01.141 [DEBUG] [.o.u.w.i.servlet.WebAppServlet] - reading sitemap home
2016-09-25 01:47:01.701 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 1.0, R=40, G=229, B=79
2016-09-25 01:47:01.703 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2 = 1.0, R=201, G=202, B=255
2016-09-25 01:47:01.705 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_2_LH = 2016-09-25T01:47:00.955PDT
2016-09-25 01:47:01.710 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1_LH = 2016-09-25T01:47:00.955PDT
2016-09-25 01:47:01.715 [DEBUG] [b.s.i.network.typicals.Monitor] - Put on Bus Events - RGB_LytBulb_1 = 229.0, R=79, G=0, B=0
2016-09-25 01:47:01.716 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 3758 packets in memory
2016-09-25 01:47:01.718 [DEBUG] [s.i.network.udp.SendDispatcher] - POP: 0 force frame sent
2016-09-25 01:47:01.721 [DEBUG] [s.i.network.udp.SendDispatcher] - Pop frame HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Delay for 'SendDispatcherThread' setted to 1000 mills.
2016-09-25 01:47:01.723 [DEBUG] [s.i.network.udp.SendDispatcher] - SendDispatcherThread - Functional Code 0x25 - Packet: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ] - Elementi rimanenti in lista: 3758
2016-09-25 01:47:01.725 [DEBUG] [.b.s.i.n.t.RefreshSUBSCRIPTION] - sendSUBSCRIPTIONframe
2016-09-25 01:47:01.726 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendSUBSCRIPTIONframe - HEX: [21 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:47:01.728 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:47:01.729 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 21 00 00 00 02 ]
2016-09-25 01:47:01.731 [DEBUG] [b.s.i.n.typicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
2016-09-25 01:47:01.732 [DEBUG] [.o.b.s.i.n.udp.SoulissCommGate] - sendHEALTY_REQUESTframe - HEX: [25 00 00 00 02 ], soulissNodeIPAddressOnLAN: 192.168.70.160
2016-09-25 01:47:01.734 [DEBUG] [s.i.network.udp.SendDispatcher] - Push
2016-09-25 01:47:01.734 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - Packet received
2016-09-25 01:47:01.738 [DEBUG] [.o.b.s.i.n.udp.UDPServerThread] - HEX: [0E 0D 17 86 47 A0 00 35 00 00 00 02 FF F3 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ]
2016-09-25 01:47:01.744 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - decodeMacaco: Received functional code: 0x35
2016-09-25 01:47:01.745 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - function_health_resp
2016-09-25 01:47:01.746 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 0; Value: 255
2016-09-25 01:47:01.748 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_1_health, Typ: 0x98, Node: 0, Slot: 998. New State: 255.0
2016-09-25 01:47:01.749 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_1_health ( 152) = 255
2016-09-25 01:47:01.750 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - request to updateHEALTY. Node: 1; Value: 243
2016-09-25 01:47:01.751 [DEBUG] [.s.i.n.t.SoulissGenericTypical] - Update State. Name: RGB_LytBulb_2_health, Typ: 0x98, Node: 1, Slot: 998. New State: 243.0
2016-09-25 01:47:01.753 [DEBUG] [.b.s.i.n.udp.UDPSoulissDecoder] - updateHEALTY: RGB_LytBulb_2_health ( 152) = 243
2016-09-25 01:47:01.754 [DEBUG] [s.i.network.udp.SendDispatcher] - Add frame: HEX: [0C 0B 17 A0 00 86 47 25 00 00 00 02 ]
2016-09-25 01:47:01.915 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.921 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.923 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:47:01.924 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.927 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.931 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.934 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:47:01.938 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.945 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.948 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:01.949 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:47:01.952 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:47:01.953 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:47:01.956 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:47:01.957 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:47:01.959 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:47:01.960 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:47:01.961 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:47:01.964 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:47:01.965 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:47:01.967 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:47:01.968 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
2016-09-25 01:47:02.143 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:02.160 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:02.161 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Text
2016-09-25 01:47:02.162 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:02.164 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:02.167 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:02.169 [DEBUG] [t.i.s.MapTransformationService] - transformation resulted in 'unknown'
2016-09-25 01:47:02.172 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:02.176 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:02.178 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item null for widget org.openhab.model.sitemap.Frame
2016-09-25 01:47:02.179 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:47:02.180 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:47:02.181 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:47:02.183 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:47:02.183 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:47:02.183 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'null'.
2016-09-25 01:47:02.184 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget null is not visible.
2016-09-25 01:47:02.184 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Target Temperature [%.1f °F]'.
2016-09-25 01:47:02.185 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Minimum Temperature [%.1f °F]'.
2016-09-25 01:47:02.186 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Minimum Temperature [%.1f °F] is not visible.
2016-09-25 01:47:02.186 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Checking visiblity for widget 'Maximum Temperature [%.1f °F]'.
2016-09-25 01:47:02.186 [DEBUG] [o.u.i.items.ItemUIRegistryImpl] - Widget Maximum Temperature [%.1f °F] is not visible.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment