Thermostat CALL Not working
******** UPDATE *******
** Version 3.0.0.10 Alpha **
I upgraded and I even first deleted the thermostat devices per install notes...
It seems that CALL is still not updating the status of the HVAC system.
Here is the ISY Event Log showing the traffic when I choose the Cooling Mode.
Here is the HS3 Log for the time-frame that overlaps:
Rich
******** UPDATE *******
** Version 3.0.0.10 Alpha **
I upgraded and I even first deleted the thermostat devices per install notes...
It seems that CALL is still not updating the status of the HVAC system.
Here is the ISY Event Log showing the traffic when I choose the Cooling Mode.
Code:
Thu 07/31/2014 09:57:55 PM : [INST-TX-I2CS] 02 62 1E 0D C8 1F 6B 05 00 00 00 00 00 00 00 00 00 00 00 00 00 90 Thu 07/31/2014 09:57:55 PM : [INST-ACK ] 02 62 1E.0D.C8 1F 6B 05 00 00 00 00 00 00 00 00 00 00 00 00 00 90 06 (05) Thu 07/31/2014 09:57:56 PM : [INST-SRX ] 02 50 1E.0D.C8 28.CE.74 2B 6B 05 (05) Thu 07/31/2014 09:57:56 PM : [Std-Direct Ack] 1E.0D.C8-->ISY/PLM Group=0, Max Hops=3, Hops Left=2 Thu 07/31/2014 09:57:56 PM : [ 1E D C8 1] CLIMD 2 Thu 07/31/2014 09:58:02 PM : [INST-SRX ] 02 50 1E.0D.C8 28.CE.74 01 70 02 (02) Thu 07/31/2014 09:58:02 PM : [Std-Direct ] 1E.0D.C8-->ISY/PLM Group=0, Max Hops=1, Hops Left=0 Thu 07/31/2014 09:58:02 PM : [INST-TX-I2CS] 02 62 1E 0D C8 1F 2E 02 00 00 00 00 00 00 00 00 00 00 00 00 92 96 Thu 07/31/2014 09:58:03 PM : [INST-ACK ] 02 62 1E.0D.C8 1F 2E 02 00 00 00 00 00 00 00 00 00 00 00 00 92 96 06 (02) Thu 07/31/2014 09:58:03 PM : [INST-SRX ] 02 50 1E.0D.C8 28.CE.74 2B 2E 02 (02) Thu 07/31/2014 09:58:03 PM : [Std-Direct Ack] 1E.0D.C8-->ISY/PLM Group=0, Max Hops=3, Hops Left=2 Thu 07/31/2014 09:58:04 PM : [INST-ERX ] 02 51 1E 0D C8 28 CE 74 11 2E 02 01 04 02 33 26 30 50 33 01 0F E1 45 07 97 Thu 07/31/2014 09:58:04 PM : [Ext-Direct ] 1E.0D.C8-->ISY/PLM Group=0, Max Hops=1, Hops Left=0
Code:
Jul-31 9:58:03 PM ISYInsteon Event Queue is now empty. Jul-31 9:58:03 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_7 A=1 N= Jul-31 9:58:03 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:58:03 PM ISYInsteon parse_event : control = [_7] action = [1] node = [] eventinfo = [[Ext-Direct ] 1E.0D.C8--{0x3E}ISY/PLM Group=0, Max Hops=1, Hops Left=0] Jul-31 9:58:03 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6260" sid="uuid:66"{0x3E3C}control{0x3E}_7{0x3C}/control{0x3E3C}action{0x3E}1{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E}[Ext-Direct ] 1E.0D.C8--{0x3E}ISY/PLM Group=0, Max Hops=1, Hops Left=0{0x3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:58:03 PM ISYInsteon Event Queue is now empty. Jul-31 9:58:03 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_7 A=1 N= Jul-31 9:58:03 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:58:03 PM ISYInsteon parse_event : control = [_7] action = [1] node = [] eventinfo = [[INST-ERX ] 02 51 1E 0D C8 28 CE 74 11 2E 02 01 04 02 33 26 30 50 33 01 0F E1 45 07 97 ] Jul-31 9:58:03 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6259" sid="uuid:66"{0x3E3C}control{0x3E}_7{0x3C}/control{0x3E3C}action{0x3E}1{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E}[INST-ERX ] 02 51 1E 0D C8 28 CE 74 11 2E 02 01 04 02 33 26 30 50 33 01 0F E1 45 07 97 {0x3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:58:02 PM ISYInsteon Event Queue is now empty. Jul-31 9:58:02 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_7 A=1 N= Jul-31 9:58:02 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:58:02 PM ISYInsteon parse_event : control = [_7] action = [1] node = [] eventinfo = [[Std-Direct Ack] 1E.0D.C8--{0x3E}ISY/PLM Group=0, Max Hops=3, Hops Left=2] Jul-31 9:58:02 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6258" sid="uuid:66"{0x3E3C}control{0x3E}_7{0x3C}/control{0x3E3C}action{0x3E}1{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E}[Std-Direct Ack] 1E.0D.C8--{0x3E}ISY/PLM Group=0, Max Hops=3, Hops Left=2{0x3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:58:02 PM ISYInsteon Event Queue is now empty. Jul-31 9:58:02 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_7 A=1 N= Jul-31 9:58:02 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:58:02 PM ISYInsteon parse_event : control = [_7] action = [1] node = [] eventinfo = [[INST-SRX ] 02 50 1E.0D.C8 28.CE.74 2B 2E 02 (02)] Jul-31 9:58:02 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6257" sid="uuid:66"{0x3E3C}control{0x3E}_7{0x3C}/control{0x3E3C}action{0x3E}1{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E}[INST-SRX ] 02 50 1E.0D.C8 28.CE.74 2B 2E 02 (02){0x3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:58:01 PM ISYInsteon Event Queue is now empty. Jul-31 9:58:01 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_7 A=1 N= Jul-31 9:58:01 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:58:01 PM ISYInsteon parse_event : control = [_7] action = [1] node = [] eventinfo = [[INST-ACK ] 02 62 1E.0D.C8 1F 2E 02 00 00 00 00 00 00 00 00 00 00 00 00 92 96 06 (02)] Jul-31 9:58:01 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6256" sid="uuid:66"{0x3E3C}control{0x3E}_7{0x3C}/control{0x3E3C}action{0x3E}1{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E}[INST-ACK ] 02 62 1E.0D.C8 1F 2E 02 00 00 00 00 00 00 00 00 00 00 00 00 92 96 06 (02){0x3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:58:01 PM ISYInsteon Event Queue is now empty. Jul-31 9:58:01 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_7 A=1 N= Jul-31 9:58:01 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:58:01 PM ISYInsteon parse_event : control = [_7] action = [1] node = [] eventinfo = [[INST-TX-I2CS] 02 62 1E 0D C8 1F 2E 02 00 00 00 00 00 00 00 00 00 00 00 00 92 96] Jul-31 9:58:01 PM ISYInsteon Event Queue is now empty. Jul-31 9:58:01 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6255" sid="uuid:66"{0x3E3C}control{0x3E}_7{0x3C}/control{0x3E3C}action{0x3E}1{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E}[INST-TX-I2CS] 02 62 1E 0D C8 1F 2E 02 00 00 00 00 00 00 00 00 00 00 00 00 92 96{0x3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:58:01 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_7 A=1 N= Jul-31 9:58:01 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:58:01 PM ISYInsteon parse_event : control = [_7] action = [1] node = [] eventinfo = [[Std-Direct ] 1E.0D.C8--{0x3E}ISY/PLM Group=0, Max Hops=1, Hops Left=0] Jul-31 9:58:01 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6254" sid="uuid:66"{0x3E3C}control{0x3E}_7{0x3C}/control{0x3E3C}action{0x3E}1{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E}[Std-Direct ] 1E.0D.C8--{0x3E}ISY/PLM Group=0, Max Hops=1, Hops Left=0{0x3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:58:01 PM ISYInsteon Event Queue is now empty. Jul-31 9:58:01 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_7 A=1 N= Jul-31 9:58:01 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:58:01 PM ISYInsteon parse_event : control = [_7] action = [1] node = [] eventinfo = [[INST-SRX ] 02 50 1E.0D.C8 28.CE.74 01 70 02 (02)] Jul-31 9:58:01 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6253" sid="uuid:66"{0x3E3C}control{0x3E}_7{0x3C}/control{0x3E3C}action{0x3E}1{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E}[INST-SRX ] 02 50 1E.0D.C8 28.CE.74 01 70 02 (02){0x3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:57:55 PM ISYInsteon Event Queue is now empty. Jul-31 9:57:55 PM ISYInsteon ISY is idle. Jul-31 9:57:55 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:57:55 PM ISYInsteon parse_event : control = [_5] action = [0] node = [] eventinfo = [] Jul-31 9:57:55 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6252" sid="uuid:66"{0x3E3C}control{0x3E}_5{0x3C}/control{0x3E3C}action{0x3E}0{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:57:55 PM ISYInsteon Event Queue is now empty. Jul-31 9:57:55 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_1 A=3 N=1E D C8 1 Jul-31 9:57:55 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:57:55 PM ISYInsteon Event Queue is now empty. Jul-31 9:57:55 PM ISYInsteon parse_event : control = [_1] action = [3] node = [] eventinfo = [[ 1E D C8 1] CLIMD 2] Jul-31 9:57:55 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6251" sid="uuid:66"{0x3E3C}control{0x3E}_1{0x3C}/control{0x3E3C}action{0x3E}3{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E}[ 1E D C8 1] CLIMD 2{0x3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:57:55 PM ISYInsteon Thermostat/Kitchen/Thermostat - Main Mode is now 2 Jul-31 9:57:55 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:57:55 PM ISYInsteon parse_event : control = [CLIMD] action = [2] node = [1E D C8 1] eventinfo = [] Jul-31 9:57:55 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6250" sid="uuid:66"{0x3E3C}control{0x3E}CLIMD{0x3C}/control{0x3E3C}action{0x3E}2{0x3C}/action{0x3E3C}node{0x3E}1E D C8 1{0x3C}/node{0x3E3C}eventInfo{0x3E3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:57:55 PM ISYInsteon Event Queue is now empty. Jul-31 9:57:55 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_7 A=1 N= Jul-31 9:57:55 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:57:55 PM ISYInsteon parse_event : control = [_7] action = [1] node = [] eventinfo = [[Std-Direct Ack] 1E.0D.C8--{0x3E}ISY/PLM Group=0, Max Hops=3, Hops Left=2] Jul-31 9:57:55 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6249" sid="uuid:66"{0x3E3C}control{0x3E}_7{0x3C}/control{0x3E3C}action{0x3E}1{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E}[Std-Direct Ack] 1E.0D.C8--{0x3E}ISY/PLM Group=0, Max Hops=3, Hops Left=2{0x3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:57:55 PM ISYInsteon Event Queue is now empty. Jul-31 9:57:55 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_7 A=1 N= Jul-31 9:57:55 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:57:55 PM ISYInsteon parse_event : control = [_7] action = [1] node = [] eventinfo = [[INST-SRX ] 02 50 1E.0D.C8 28.CE.74 2B 6B 05 (05)] Jul-31 9:57:55 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6248" sid="uuid:66"{0x3E3C}control{0x3E}_7{0x3C}/control{0x3E3C}action{0x3E}1{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E}[INST-SRX ] 02 50 1E.0D.C8 28.CE.74 2B 6B 05 (05){0x3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:57:54 PM ISYInsteon Command Queue is now empty. Jul-31 9:57:54 PM ISYInsteon Event Queue is now empty. Jul-31 9:57:54 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_7 A=1 N= Jul-31 9:57:54 PM ISYInsteon Add : Event added to queue. Queue size = 1 Jul-31 9:57:54 PM ISYInsteon parse_event : control = [_7] action = [1] node = [] eventinfo = [[INST-ACK ] 02 62 1E.0D.C8 1F 6B 05 00 00 00 00 00 00 00 00 00 00 00 00 00 90 06 (05)] Jul-31 9:57:54 PM ISYInsteon parse_event : Entering parse event with {0x3C}Event seqnum="6247" sid="uuid:66"{0x3E3C}control{0x3E}_7{0x3C}/control{0x3E3C}action{0x3E}1{0x3C}/action{0x3E3C}node{0x3E3C}/node{0x3E3C}eventInfo{0x3E}[INST-ACK ] 02 62 1E.0D.C8 1F 6B 05 00 00 00 00 00 00 00 00 00 00 00 00 00 90 06 (05){0x3C}/eventInfo{0x3E3C}/Event{0x3E00} Jul-31 9:57:54 PM ISYInsteon Event Queue is now empty. Jul-31 9:57:54 PM ISYInsteon ProcessEvent : NOT HANDLED: Unsupported ISY message: C=_7 A=1 N= Jul-31 9:57:54 PM ISYInsteon Add : Event added to queue. Queue size = 1
Comment