Code: Alles auswählen
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1074]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 2, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1074]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1074]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:18 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 0.000000 valR1 = 1.000000 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 2, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 0.000000 valR1 = 1.000000 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 0.000000 valR1 = 1.000000 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 2 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 2 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 3 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 1 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 2 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 2 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 3 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 2, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 3, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 4, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 2, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 0.000000 valR1 = 1.000000 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 3, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 1 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 2, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1074]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 3 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1074]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, trigger dp exists [iseCondition.cpp:524]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_EXECUTE is reset. [iseCondition.cpp:1112]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, CONDITION_TRIGGER_EXECUTE is reset. [iseRule.cpp:227]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Rule evaluated state is FALSE by Program ID = 1467 'An-und-Abwesenheiten-Steuerung v2' [iseDOMPrg.cpp:527]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 14929 'Status Eingangst¸r' with valNew = '0' ; oidTrigger = 3795 [iseDOMPrg.cpp:478]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, trigger dp exists [iseCondition.cpp:524]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1074]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_EXECUTE is reset. [iseCondition.cpp:1112]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_EXECUTE is reset. [iseRule.cpp:227]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 14929 'Status Eingangst¸r'; Destination ID = 44589 [iseDOMPrg.cpp:501]
Jan 25 18:31:18 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: break execute for Program ID = 14929 'Status Eingangst¸r', rule's trigger flags = 0 [iseDOMPrg.cpp:521]
Jan 25 18:31:18 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 1 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 2 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 3 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 4 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 5 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 6 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 7 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:19 ccu2 user.debug multimac: C> @142397: #72 LLMAC Response ACK @11427: 2C A3
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseXmlRpc::GetInterfaceByID: interface name= CUxD for ID=12941 [iseXmlRpc.cpp:2549]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseXmlRpc::CallXmlrpcMethod: method =setValue params = {"CUX2801001:1","CMD_EXEC","logger -t script -p user.debug [ALCHY ALLINScript START]"} result = "" [iseXmlRpc.cpp:2610]
Jan 25 18:31:19 ccu2 user.debug script: [ALCHY ALLINScript START]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 49207 'Push Script for pocket control' with valNew = 'ALTE Servicemeldung^M ^M Luca_H_LEQ0781933 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M SZ_LEQ0785414 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M DB_H_LEQ0784289 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M HM-LC-Sw4-Ba-PCB NEQ0027554 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:30 (25.01.19 18:31)^M ^M Flur_unten_BWM_HmIP-SMI55 0014D8A98A143A : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M ' ; oidTrigger = 2487 [iseDOMPrg.cpp:478]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, trigger dp exists [iseCondition.cpp:500]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_VALUE_IN_RANGE_FROM_TO, condition valL = ALTE Servicemeldung^M ^M Luca_H_LEQ0781933 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M SZ_LEQ0785414 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M DB_H_LEQ0784289 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M HM-LC-Sw4-Ba-PCB NEQ0027554 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:30 (25.01.19 18:31)^M ^M Flur_unten_BWM_HmIP-SMI55 0014D8A98A143A : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M valR1 = valR2 = [iseCondition.cpp:355]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_TRUE is set. [iseCondition.cpp:1117]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_TRUE is set. [iseRule.cpp:232]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 49207 'Push Script for pocket control'; Destination ID = 4214 [iseDOMPrg.cpp:501]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Program ID = 49207 'Push Script for pocket control', rule's trigger flags = 6 [iseDOMPrg.cpp:515]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: execute Program ID = 49207 'Push Script for pocket control'; Destination ID = 4214 [iseDOMPrg.cpp:611]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: start execute Destination within the trigger delay 0 [iseDOMPrg.cpp:615]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: SchedulerRT::Add: added script element - id= 4214; time= 0 [iseRTScheduler.cpp:343]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: pDest->ExecuteDestination succeeded from Program ID = 49207 'Push Script for pocket control' with valNew = 'ALTE Servicemeldung^M ^M Luca_H_LEQ0781933 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M SZ_LEQ0785414 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M DB_H_LEQ0784289 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M HM-LC-Sw4-Ba-PCB NEQ0027554 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:30 (25.01.19 18:31)^M ^M Flur_unten_BWM_HmIP-SMI55 0014D8A98A143A : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M ' [iseDOMPrg.cpp:625]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseXmlRpc::GetInterfaceByID: interface name= CUxD for ID=12941 [iseXmlRpc.cpp:2549]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseXmlRpc::CallXmlrpcMethod: method =setValue params = {"CUX2801001:1","CMD_EXEC","logger -t script -p user.debug [ALCHY ALLINScript ENDE]"} result = "" [iseXmlRpc.cpp:2610]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteScript: id = 59657; ticks = 21 [iseRTScheduler.cpp:601]
Jan 25 18:31:19 ccu2 user.debug script: [ALCHY ALLINScript ENDE]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IsePersist::ExecProcess = 'wget -q -O /dev/null '--post-data=ccuid=P_2487C748-EDF5-475C-B10E-5C570ECA9B96&push=ALTE%20Servicemeldung^M ^M Luca_H_LEQ0781933%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:31%20(25.01.19%2018:31)^M ^M SZ_LEQ0785414%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:31%20(25.01.19%2018:31)^M ^M DB_H_LEQ0784289%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:31%20(25.01.19%2018:31)^M ^M HM-LC-Sw4-Ba-PCB%20NEQ0027554%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:30%20(25.01.19%2018:31)^M ^M Flur_unten_BWM_HmIP-SMI55%200014D8A98A143A%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:31%20(25.01.19%2018:31)^M ^M %20' http://push.pocket-control.com:9325 &' returned 0 [iseDOMpersist.cpp:380]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteScript: id = 4214; ticks = 10 [iseRTScheduler.cpp:601]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 3000 [iseRTScheduler.cpp:481]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 3000 [iseRTScheduler.cpp:481]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 317 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 226 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 325 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 230 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 233 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueList=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').ValueList() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 305 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 220 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:21 ccu2 user.err rfd: LGWPortWrapper::ReadData(): Receive error
Jan 25 18:31:21 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:21 ccu2 user.debug rfd: LGWPortWrapper::asyncReconnect(): Reconnect already in progress.
Jan 25 18:31:21 ccu2 auth.info sshd[2458]: Accepted password for root from 192.168.178.22 port 54503 ssh2
Jan 25 18:31:21 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Trying to reconnect.
Jan 25 18:31:21 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Perform connect.
Jan 25 18:31:22 ccu2 local0.info ReGaHss: Info: SchedulerRT::ExecuteWriteJob: try to call set state - DP id = 2052 value = 0 [iseRTScheduler.cpp:629]
Jan 25 18:31:22 ccu2 local0.info ReGaHss: Info: IseXmlRpc::GetInterfaceByID: interface name= BidCos-RF for ID=1007 [iseXmlRpc.cpp:2549]
Jan 25 18:31:22 ccu2 user.debug rfd: TX: @2249255610 0x31AF12 -> 0x2F0145 Generic [NEQ0708485]: CNT=1,RPTEN=1,RPTED=0,BIDI=1,BURST=1,WAKEUP=0,WAKEMEUP=0,BCAST=0,TYPE=0x11 DATA = 80
Jan 25 18:31:22 ccu2 user.info rfd: Lan Device Information: Protocol-Version: 1 Product-ID: Revilo-HM-LGW Firmware-Version: 0.0.2 Serial Number: MEQ0835478
Jan 25 18:31:22 ccu2 user.debug multimac: C> @145943: #40 LLMAC RX @14993ms -69dBm 01 B0 11 31 AF 12 2F 01 45 80
Jan 25 18:31:22 ccu2 user.debug multimac: Bidcos RX: #01[BiDi|WOR|Ren] 31AF12->2F0145 CentralCommand: 80
Jan 25 18:31:22 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:22 ccu2 user.debug multimac: A<: #82 HmBidcos RxTelegram AuthNone #01[BiDi|WOR|Ren] 31AF12->2F0145 CentralCommand: 80
Jan 25 18:31:22 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initialize coprocessor.
Jan 25 18:31:22 ccu2 user.debug rfd: CCU2CommController::improvedInit() - Coprocessor is in bootloader, going to start application.
Jan 25 18:31:23 ccu2 user.debug rfd: (MEQ0835478) CCU2CommController::handleIdentifyEvent(): Coprocessor entered application. Life is good.
Jan 25 18:31:23 ccu2 user.info rfd: (MEQ0835478) CCU2CommController::setCSMACAEnabled(): CSMA/CA disabled.
Jan 25 18:31:23 ccu2 user.debug rfd: (MEQ0835478) Response status: OK.
Jan 25 18:31:23 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initializing keepalives.
Jan 25 18:31:23 ccu2 user.debug rfd: LGWPortWrapper::connect(): Reconnected.
Jan 25 18:31:23 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Reconnect finished.
Jan 25 18:31:23 ccu2 user.info rfd: LanConnection::receive(): sock 16: Remote host closed connection.
Jan 25 18:31:23 ccu2 user.debug multimac: C> @147095: #41 LLMAC RX @16145ms -69dBm 01 B0 11 31 AF 12 2F 01 45 80
Jan 25 18:31:23 ccu2 user.debug multimac: Bidcos RX: #01[BiDi|WOR|Ren] 31AF12->2F0145 CentralCommand: 80
Jan 25 18:31:23 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:23 ccu2 user.debug multimac: A<: #84 HmBidcos RxTelegram AuthNone #01[BiDi|WOR|Ren] 31AF12->2F0145 CentralCommand: 80
Jan 25 18:31:23 ccu2 user.debug rfd: (NEQ0708485) Response status: Telegram sent, received ACK.
Jan 25 18:31:23 ccu2 user.debug rfd: (MEQ0835478) Telegram Response status: OK.
Jan 25 18:31:23 ccu2 user.debug rfd: Response accepted: @2249257281 RSSI=-65dB 0x2F0145 -> 0x31AF12 ACK_STATUS [NEQ0708485]: CNT=1,RPTEN=1,RPTED=0,BIDI=0,BURST=0,WAKEUP=0,WAKEMEUP=0,BCAST=0,TYPE=0x02 CHANNEL = 4 STATUS = 39 STATE = 0 CLOCK = 0 LOWBAT = 0 DUTY_CYCLE = 0 RSSI = 69
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.CONTROL_MODE=0
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.FAULT_REPORTING=0
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.BOOST_STATE=0
Jan 25 18:31:23 ccu2 user.debug multimac: C> @147229: #42 LLMAC RX @16278ms -79dBm 01 80 02 2F 01 45 31 AF 12 01 04 27 00 45 00
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:23 ccu2 user.debug multimac: Bidcos RX: #01[Ren] 2F0145->31AF12 Ack: 01 04 27 00 45 00
Jan 25 18:31:23 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:23 ccu2 user.debug multimac: A<: #86 HmBidcos RxTelegram AuthNone #01[Ren] 2F0145->31AF12 Ack: 01 04 27 00 45 00
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.SET_TEMPERATURE=19.500000
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."CONTROL_MODE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_TEMPERATURE=5.000000
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_START_TIME=0
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_START_DAY=1
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 5 events
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."FAULT_REPORTING"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_START_MONTH=1
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_START_YEAR=0
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_STOP_TIME=0
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_STOP_DAY=1
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_STOP_MONTH=1
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 3 events
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 10 events
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_STOP_YEAR=0
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: IseXmlRpc::CallXmlrpcMethod: method =setValue params = {"LEQ0786107:4","AUTO_MODE",false} result = "" [iseXmlRpc.cpp:2610]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: SchedulerRT::ExecuteWriteJob: set state - DP id = 2052 [iseRTScheduler.cpp:634]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteWriteJob: oid = 2052; ticks = 1677 [iseRTScheduler.cpp:591]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."BOOST_STATE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 4000 [iseRTScheduler.cpp:481]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 user.debug rfd: RX for LEQ0786107: @2249257281 RSSI=-65dB 0x2F0145 -> 0x31AF12 ACK_STATUS [NEQ0708485]: CNT=1,RPTEN=1,RPTED=0,BIDI=0,BURST=0,WAKEUP=0,WAKEMEUP=0,BCAST=0,TYPE=0x02 CHANNEL = 4 STATUS = 39 STATE = 0 CLOCK = 0 LOWBAT = 0 DUTY_CYCLE = 0 RSSI = 69
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."SET_TEMPERATURE"=19.500000 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 19.500000 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_TEMPERATURE"=5.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 1 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 5.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 2 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_START_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 3 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 4 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_START_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 5 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 11 events
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_START_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 6 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_START_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_STOP_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 7 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_STOP_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_STOP_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_STOP_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:24 ccu2 user.debug multimac: C<: #73 TRX GetDutyCycle
Jan 25 18:31:24 ccu2 user.debug multimac: C< @148177: bin:FD 00 03 01 49 03 2E 1B
Jan 25 18:31:24 ccu2 user.debug multimac: C> @148281: #73 TRX Response Ack 08
Jan 25 18:31:24 ccu2 user.debug multimac: SubsystemBidcos::CheckDutyCycleEventThreshold( 4.0, 4.0 ) = 0
Jan 25 18:31:25 ccu2 user.err rfd: UnifiedLanCommController::connect(): Could not connect.
Jan 25 18:31:25 ccu2 user.err rfd: LGWPortWrapper::keepAliveThreadFunction(): Cannot connect.
Jan 25 18:31:25 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:25 ccu2 user.debug rfd: asyncReconnect -> reconnect
Jan 25 18:31:27 ccu2 local0.info ReGaHss: Info: SchedulerRT::ExecuteWriteJob: try to call set state - DP id = 1351 value = 0 [iseRTScheduler.cpp:629]
Jan 25 18:31:27 ccu2 local0.info ReGaHss: Info: IseXmlRpc::GetInterfaceByID: interface name= BidCos-RF for ID=1007 [iseXmlRpc.cpp:2549]
Jan 25 18:31:27 ccu2 user.debug rfd: TX: @2249261288 0x31AF12 -> 0x3105F2 Generic [NEQ0708485]: CNT=1,RPTEN=1,RPTED=0,BIDI=1,BURST=1,WAKEUP=0,WAKEMEUP=0,BCAST=0,TYPE=0x11 DATA = 80
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 user.debug multimac: C> @151621: #43 LLMAC RX @20671ms -66dBm 01 B0 11 31 AF 12 31 05 F2 80
Jan 25 18:31:28 ccu2 user.debug multimac: Bidcos RX: #01[BiDi|WOR|Ren] 31AF12->3105F2 CentralCommand: 80
Jan 25 18:31:28 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:28 ccu2 user.debug multimac: A<: #89 HmBidcos RxTelegram AuthNone #01[BiDi|WOR|Ren] 31AF12->3105F2 CentralCommand: 80
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 317 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 226 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 325 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 230 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 user.debug rfd: (NEQ0708485) Response status: Telegram sent, received ACK.
Jan 25 18:31:28 ccu2 user.debug rfd: Response accepted: @2249261806 RSSI=-38dB 0x3105F2 -> 0x31AF12 ACK_STATUS [NEQ0708485]: CNT=1,RPTEN=1,RPTED=0,BIDI=0,BURST=0,WAKEUP=0,WAKEMEUP=0,BCAST=0,TYPE=0x02 CHANNEL = 4 STATUS = 40 STATE = 0 CLOCK = 0 LOWBAT = 0 DUTY_CYCLE = 0 RSSI = 37
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.CONTROL_MODE=0
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.FAULT_REPORTING=0
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.BOOST_STATE=0
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.SET_TEMPERATURE=20.000000
Jan 25 18:31:28 ccu2 user.debug multimac: C> @151754: #44 LLMAC RX @20803ms -67dBm 01 80 02 31 05 F2 31 AF 12 01 04 28 00 25 00
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."CONTROL_MODE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 user.debug multimac: Bidcos RX: #01[Ren] 3105F2->31AF12 Ack: 01 04 28 00 25 00
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_TEMPERATURE=5.000000
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:28 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_START_TIME=0
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_START_DAY=1
Jan 25 18:31:28 ccu2 user.debug multimac: A<: #91 HmBidcos RxTelegram AuthNone #01[Ren] 3105F2->31AF12 Ack: 01 04 28 00 25 00
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_START_MONTH=1
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_START_YEAR=0
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_STOP_TIME=0
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 4 events
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_STOP_DAY=1
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_STOP_MONTH=1
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_STOP_YEAR=0
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 5 events
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 12 events
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseXmlRpc::CallXmlrpcMethod: method =setValue params = {"LEQ1085122:4","AUTO_MODE",false} result = "" [iseXmlRpc.cpp:2610]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: SchedulerRT::ExecuteWriteJob: set state - DP id = 1351 [iseRTScheduler.cpp:634]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteWriteJob: oid = 1351; ticks = 526 [iseRTScheduler.cpp:591]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."FAULT_REPORTING"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 user.debug rfd: RX for LEQ1085122: @2249261806 RSSI=-38dB 0x3105F2 -> 0x31AF12 ACK_STATUS [NEQ0708485]: CNT=1,RPTEN=1,RPTED=0,BIDI=0,BURST=0,WAKEUP=0,WAKEMEUP=0,BCAST=0,TYPE=0x02 CHANNEL = 4 STATUS = 40 STATE = 0 CLOCK = 0 LOWBAT = 0 DUTY_CYCLE = 0 RSSI = 37
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 11 events
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."BOOST_STATE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 1 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."SET_TEMPERATURE"=20.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 20.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_TEMPERATURE"=5.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteScript: id = 57266; ticks = 102 [iseRTScheduler.cpp:601]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 2 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 569000 [iseRTScheduler.cpp:481]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 5.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_START_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 3 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_START_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_START_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 4 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_START_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_STOP_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 5 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_STOP_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 6 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_STOP_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_STOP_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 7 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 233 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueList=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').ValueList() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 305 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 220 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 user.err rfd: LGWPortWrapper::ReadData(): Receive error
Jan 25 18:31:28 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:28 ccu2 user.debug rfd: LGWPortWrapper::asyncReconnect(): Reconnect already in progress.
Jan 25 18:31:29 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Trying to reconnect.
Jan 25 18:31:29 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Perform connect.
Jan 25 18:31:29 ccu2 user.info rfd: Lan Device Information: Protocol-Version: 1 Product-ID: Revilo-HM-LGW Firmware-Version: 0.0.2 Serial Number: MEQ0835478
Jan 25 18:31:30 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initialize coprocessor.
Jan 25 18:31:30 ccu2 user.debug rfd: CCU2CommController::improvedInit() - Coprocessor is in bootloader, going to start application.
Jan 25 18:31:30 ccu2 user.debug rfd: (MEQ0835478) CCU2CommController::handleIdentifyEvent(): Coprocessor entered application. Life is good.
Jan 25 18:31:30 ccu2 user.info rfd: (MEQ0835478) CCU2CommController::setCSMACAEnabled(): CSMA/CA disabled.
Jan 25 18:31:30 ccu2 user.debug rfd: (MEQ0835478) Response status: OK.
Jan 25 18:31:30 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initializing keepalives.
Jan 25 18:31:30 ccu2 user.debug rfd: LGWPortWrapper::connect(): Reconnected.
Jan 25 18:31:30 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Reconnect finished.
Jan 25 18:31:30 ccu2 user.info rfd: LanConnection::receive(): sock 14: Remote host closed connection.
Jan 25 18:31:32 ccu2 user.err rfd: UnifiedLanCommController::connect(): Could not connect.
Jan 25 18:31:32 ccu2 user.err rfd: LGWPortWrapper::keepAliveThreadFunction(): Cannot connect.
Jan 25 18:31:32 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:32 ccu2 user.debug rfd: asyncReconnect -> reconnect
Jan 25 18:31:32 ccu2 auth.info sshd[2968]: Accepted password for root from 192.168.178.22 port 54504 ssh2
Jan 25 18:31:34 ccu2 user.debug multimac: C<: #74 TRX GetDutyCycle
Jan 25 18:31:34 ccu2 user.debug multimac: C< @158177: bin:FD 00 03 01 4A 03 24 1B
Jan 25 18:31:34 ccu2 user.debug multimac: C> @158281: #74 TRX Response Ack 08
Jan 25 18:31:34 ccu2 user.debug multimac: SubsystemBidcos::CheckDutyCycleEventThreshold( 4.0, 4.0 ) = 0
Jan 25 18:31:35 ccu2 user.err rfd: LGWPortWrapper::ReadData(): Receive error
Jan 25 18:31:35 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:35 ccu2 user.debug rfd: LGWPortWrapper::asyncReconnect(): Reconnect already in progress.
Jan 25 18:31:35 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Trying to reconnect.
Jan 25 18:31:35 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Perform connect.
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 317 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 226 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 325 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 230 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 233 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueList=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').ValueList() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 305 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 220 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 user.info rfd: Lan Device Information: Protocol-Version: 1 Product-ID: Revilo-HM-LGW Firmware-Version: 0.0.2 Serial Number: MEQ0835478
Jan 25 18:31:37 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initialize coprocessor.
Jan 25 18:31:37 ccu2 user.debug rfd: CCU2CommController::improvedInit() - Coprocessor is in bootloader, going to start application.
Jan 25 18:31:37 ccu2 user.debug rfd: (MEQ0835478) CCU2CommController::handleIdentifyEvent(): Coprocessor entered application. Life is good.
Jan 25 18:31:37 ccu2 user.info rfd: (MEQ0835478) CCU2CommController::setCSMACAEnabled(): CSMA/CA disabled.
Jan 25 18:31:37 ccu2 user.debug rfd: (MEQ0835478) Response status: OK.
Jan 25 18:31:37 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initializing keepalives.
Jan 25 18:31:37 ccu2 user.debug rfd: LGWPortWrapper::connect(): Reconnected.
Jan 25 18:31:37 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Reconnect finished.
Jan 25 18:31:37 ccu2 user.info rfd: LanConnection::receive(): sock 14: Remote host closed connection.
Jan 25 18:31:39 ccu2 user.err rfd: UnifiedLanCommController::connect(): Could not connect.
Jan 25 18:31:39 ccu2 user.err rfd: LGWPortWrapper::keepAliveThreadFunction(): Cannot connect.
Jan 25 18:31:39 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:39 ccu2 user.debug rfd: asyncReconnect -> reconnect
Jan 25 18:31:42 ccu2 user.err rfd: LGWPortWrapper::ReadData(): Receive error
Jan 25 18:31:42 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:42 ccu2 user.debug rfd: LGWPortWrapper::asyncReconnect(): Reconnect already in progress.
Jan 25 18:31:42 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Trying to reconnect.
Jan 25 18:31:42 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Perform connect.
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."TIMER_GET"=0.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."TIMER_NUM"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."TIMER_GET"=60.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 60.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."TIMER_EVENT"=true [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."STATE"=true [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."TS"="1548437563" [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1548437563 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."WORKING"=true [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 user.info rfd: Lan Device Information: Protocol-Version: 1 Product-ID: Revilo-HM-LGW Firmware-Version: 0.0.2 Serial Number: MEQ0835478
Jan 25 18:31:43 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initialize coprocessor.
Jan 25 18:31:43 ccu2 user.debug rfd: CCU2CommController::improvedInit() - Coprocessor is in bootloader, going to start application.
Jan 25 18:31:44 ccu2 user.debug rfd: (MEQ0835478) CCU2CommController::handleIdentifyEvent(): Coprocessor entered application. Life is good.
Jan 25 18:31:44 ccu2 user.info rfd: (MEQ0835478) CCU2CommController::setCSMACAEnabled(): CSMA/CA disabled.
Jan 25 18:31:44 ccu2 user.debug rfd: (MEQ0835478) Response status: OK.
Jan 25 18:31:44 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initializing keepalives.
Jan 25 18:31:44 ccu2 user.debug rfd: LGWPortWrapper::connect(): Reconnected.
Jan 25 18:31:44 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Reconnect finished.
Jan 25 18:31:44 ccu2 user.info rfd: LanConnection::receive(): sock 14: Remote host closed connection.
Jan 25 18:31:44 ccu2 user.debug multimac: C<: #75 TRX GetDutyCycle
Jan 25 18:31:44 ccu2 user.debug multimac: C< @168178: bin:FD 00 03 01 4B 03 A2 18
Jan 25 18:31:44 ccu2 user.debug multimac: C> @168282: #75 TRX Response Ack 08
Jan 25 18:31:44 ccu2 user.debug multimac: SubsystemBidcos::CheckDutyCycleEventThreshold( 4.0, 4.0 ) = 0
Jan 25 18:31:45 ccu2 user.debug rfd: RX for LEQ0781933: @2249278474 RSSI=-63dB 0x2E1D17 -> 0x000000 Generic [MEQ0835478]: CNT=52,RPTEN=1,RPTED=0,BIDI=0,BURST=0,WAKEUP=0,WAKEMEUP=1,BCAST=1,TYPE=0x10 DATA = 0A 9C D4 0A 00 00
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:0.UNREACH=false
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug multimac: C> @168423: #45 LLMAC RX @ 4703ms -83dBm 34 86 10 2E 1D 17 00 00 00 0A 9C D4 0A 00 00
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.CONTROL_MODE=0
Jan 25 18:31:45 ccu2 user.debug multimac: Bidcos RX: #34[BC|Ren|WMup] 2E1D17->000000 Info: 0A 9C D4 0A 00 00
Jan 25 18:31:45 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:45 ccu2 user.debug multimac: A<: #95 HmBidcos RxTelegram AuthNone #34[BC|Ren|WMup] 2E1D17->000000 Info: 0A 9C D4 0A 00 00
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.FAULT_REPORTING=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.BATTERY_STATE=2.500000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.VALVE_STATE=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.BOOST_STATE=0
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.ACTUAL_TEMPERATURE=21.200000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.SET_TEMPERATURE=19.500000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_TEMPERATURE=5.000000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_START_TIME=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_START_DAY=1
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_START_MONTH=1
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_START_YEAR=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_STOP_TIME=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_STOP_DAY=1
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_STOP_MONTH=1
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_STOP_YEAR=0
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:0"."UNREACH"=false [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1518 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseAlarmDP::WriteValue -> Alarm is not receipted until now! [iseDOMdpAlarm.cpp:295]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 4 events
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."CONTROL_MODE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 11 events
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 15 events
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."FAULT_REPORTING"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseAlarmDP (OID=1540 Type:Alarm) changed to Receipted state! [iseDOMdpAlarm.cpp:226]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 59655 'Servicemeldungen all in v1.98' with valNew = '4' ; oidTrigger = 41 [iseDOMPrg.cpp:478]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, trigger dp exists [iseCondition.cpp:500]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_GREATER, condition valL = 4 valR1 = 0 [iseCondition.cpp:313]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_TRUE is set. [iseCondition.cpp:1117]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_TRUE is set. [iseRule.cpp:232]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 1 [iseRule.cpp:235]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 59655 'Servicemeldungen all in v1.98'; Destination ID = 59657 [iseDOMPrg.cpp:501]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Program ID = 59655 'Servicemeldungen all in v1.98', rule's trigger flags = 6 [iseDOMPrg.cpp:515]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: execute Program ID = 59655 'Servicemeldungen all in v1.98'; Destination ID = 59657 [iseDOMPrg.cpp:611]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: start execute Destination within the trigger delay 0 [iseDOMPrg.cpp:615]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::Add: added script element - id= 59657; time= 1548437506 [iseRTScheduler.cpp:343]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 1000 [iseRTScheduler.cpp:481]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: pDest->ExecuteDestination succeeded from Program ID = 59655 'Servicemeldungen all in v1.98' with valNew = '4' [iseDOMPrg.cpp:625]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 57264 'System - Servicemeldungen bestaetigen' with valNew = '4' ; oidTrigger = 41 [iseDOMPrg.cpp:478]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, trigger dp exists [iseCondition.cpp:500]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_GREATER, condition valL = 4 valR1 = 0 [iseCondition.cpp:313]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_TRUE is set. [iseCondition.cpp:1117]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_TRUE is set. [iseRule.cpp:232]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 1 [iseRule.cpp:235]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 57264 'System - Servicemeldungen bestaetigen'; Destination ID = 57266 [iseDOMPrg.cpp:501]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Program ID = 57264 'System - Servicemeldungen bestaetigen', rule's trigger flags = 6 [iseDOMPrg.cpp:515]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: execute Program ID = 57264 'System - Servicemeldungen bestaetigen'; Destination ID = 57266 [iseDOMPrg.cpp:611]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: start execute Destination within the trigger delay 0 [iseDOMPrg.cpp:615]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::Add: added script element - id= 57266; time= 1548437515 [iseRTScheduler.cpp:343]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: pDest->ExecuteDestination succeeded from Program ID = 57264 'System - Servicemeldungen bestaetigen' with valNew = '4' [iseDOMPrg.cpp:625]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."BATTERY_STATE"=2.500000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 1 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 1000 [iseRTScheduler.cpp:481]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 2.500000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."VALVE_STATE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 2 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."BOOST_STATE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 3 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 4 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 15 events
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."ACTUAL_TEMPERATURE"=21.200000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 5 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 21.200000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 6 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 7 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."SET_TEMPERATURE"=19.500000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 19.500000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_TEMPERATURE"=5.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 5.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_START_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_START_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_START_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_START_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_STOP_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_STOP_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_STOP_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_STOP_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: RX for LEQ0785414: @2249278522 RSSI=-53dB 0x2C95BD -> 0x000000 Generic [MEQ0835478]: CNT=23,RPTEN=1,RPTED=0,BIDI=0,BURST=0,WAKEUP=0,WAKEMEUP=1,BCAST=1,TYPE=0x10 DATA = 0A 9C D1 0B 00 00
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:0.UNREACH=false
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.CONTROL_MODE=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.FAULT_REPORTING=0
Jan 25 18:31:45 ccu2 user.debug multimac: C> @168470: #46 LLMAC RX @ 4751ms -83dBm 17 86 10 2C 95 BD 00 00 00 0A 9C D1 0B 00 00
Jan 25 18:31:45 ccu2 user.debug multimac: Bidcos RX: #17[BC|Ren|WMup] 2C95BD->000000 Info: 0A 9C D1 0B 00 00
Jan 25 18:31:45 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 3 events
Jan 25 18:31:45 ccu2 user.debug multimac: A<: #97 HmBidcos RxTelegram AuthNone #17[BC|Ren|WMup] 2C95BD->000000 Info: 0A 9C D1 0B 00 00
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 3 events
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:0"."UNREACH"=false [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1597 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.BATTERY_STATE=2.600000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.VALVE_STATE=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.BOOST_STATE=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.ACTUAL_TEMPERATURE=20.900000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.SET_TEMPERATURE=19.500000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_TEMPERATURE=5.000000
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_START_TIME=0
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."CONTROL_MODE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_START_DAY=1
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_START_MONTH=1
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_START_YEAR=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_STOP_TIME=0
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseAlarmDP::WriteValue -> Alarm is not receipted until now! [iseDOMdpAlarm.cpp:295]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."FAULT_REPORTING"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_STOP_DAY=1
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_STOP_MONTH=1
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 13 events
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_STOP_YEAR=0
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 6 events
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 8 events
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 14 events
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseAlarmDP (OID=1619 Type:Alarm) changed to Receipted state! [iseDOMdpAlarm.cpp:226]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 1 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."BATTERY_STATE"=2.600000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 2.600000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."VALVE_STATE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 2 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."BOOST_STATE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 3 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."ACTUAL_TEMPERATURE"=20.900000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 20.900000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."SET_TEMPERATURE"=19.500000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 4 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 5 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 6 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 7 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 59655 'Servicemeldungen all in v1.98' with valNew = '3' ; oidTrigger = 41 [iseDOMPrg.cpp:478]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, trigger dp exists [iseCondition.cpp:500]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_GREATER, condition valL = 3 valR1 = 0 [iseCondition.cpp:313]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_TRUE is set. [iseCondition.cpp:1117]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_TRUE is set. [iseRule.cpp:232]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 1 [iseRule.cpp:235]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 59655 'Servicemeldungen all in v1.98'; Destination ID = 59657 [iseDOMPrg.cpp:501]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Program ID = 59655 'Servicemeldungen all in v1.98', rule's trigger flags = 6 [iseDOMPrg.cpp:515]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: execute Program ID = 59655 'Servicemeldungen all in v1.98'; Destination ID = 59657 [iseDOMPrg.cpp:611]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: start execute Destination within the trigger delay 0 [iseDOMPrg.cpp:615]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 10000 [iseRTScheduler.cpp:481]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::Add: added script element - id= 59657; time= 1548437506 [iseRTScheduler.cpp:343]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 1000 [iseRTScheduler.cpp:481]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: pDest->ExecuteDestination succeeded from Program ID = 59655 'Servicemeldungen all in v1.98' with valNew = '3' [iseDOMPrg.cpp:625]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 57264 'System - Servicemeldungen bestaetigen' with valNew = '3' ; oidTrigger = 41 [iseDOMPrg.cpp:478]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, trigger dp exists [iseCondition.cpp:500]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_GREATER, condition valL = 3 valR1 = 0 [iseCondition.cpp:313]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_TRUE is set. [iseCondition.cpp:1117]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 19.500000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_TEMPERATURE"=5.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_TRUE is set. [iseRule.cpp:232]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 1 [iseRule.cpp:235]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 57264 'System - Servicemeldungen bestaetigen'; Destination ID = 57266 [iseDOMPrg.cpp:501]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Program ID = 57264 'System - Servicemeldungen bestaetigen', rule's trigger flags = 6 [iseDOMPrg.cpp:515]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 5.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_START_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: execute Program ID = 57264 'System - Servicemeldungen bestaetigen'; Destination ID = 57266 [iseDOMPrg.cpp:611]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_START_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: start execute Destination within the trigger delay 0 [iseDOMPrg.cpp:615]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_START_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 3 events
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 1000 [iseRTScheduler.cpp:481]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 1000 [iseRTScheduler.cpp:481]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::Add: added script element - id= 57266; time= 1548437515 [iseRTScheduler.cpp:343]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_START_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: pDest->ExecuteDestination succeeded from Program ID = 57264 'System - Servicemeldungen bestaetigen' with valNew = '3' [iseDOMPrg.cpp:625]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_STOP_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_STOP_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_STOP_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_STOP_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 317 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 226 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 325 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 230 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 233 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueList=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').ValueList() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 305 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 220 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: IseXmlRpc::GetInterfaceByID: interface name= CUxD for ID=12941 [iseXmlRpc.cpp:2549]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: IseXmlRpc::CallXmlrpcMethod: method =setValue params = {"CUX2801001:1","CMD_EXEC","logger -t script -p user.debug [ALCHY ALLINScript START]"} result = "" [iseXmlRpc.cpp:2610]
Jan 25 18:31:46 ccu2 user.debug script: [ALCHY ALLINScript START]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 49207 'Push Script for pocket control' with valNew = 'ALTE Servicemeldung^M ^M DB_H_LEQ0784289 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M HM-LC-Sw4-Ba-PCB NEQ0027554 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:30 (25.01.19 18:31)^M ^M Flur_unten_BWM_HmIP-SMI55 0014D8A98A143A : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M ' ; oidTrigger = 2487 [iseDOMPrg.cpp:478]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, trigger dp exists [iseCondition.cpp:500]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_VALUE_IN_RANGE_FROM_TO, condition valL = ALTE Servicemeldung^M ^M DB_H_LEQ0784289 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M HM-LC-Sw4-Ba-PCB NEQ0027554 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:30 (25.01.19 18:31)^M ^M Flur_unten_BWM_HmIP-SMI55 0014D8A98A143A : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M valR1 = valR2 = [iseCondition.cpp:355]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_TRUE is set. [iseCondition.cpp:1117]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_TRUE is set. [iseRule.cpp:232]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 49207 'Push Script for pocket control'; Destination ID = 4214 [iseDOMPrg.cpp:501]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Program ID = 49207 'Push Script for pocket control', rule's trigger flags = 6 [iseDOMPrg.cpp:515]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: execute Program ID = 49207 'Push Script for pocket control'; Destination ID = 4214 [iseDOMPrg.cpp:611]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: start execute Destination within the trigger delay 0 [iseDOMPrg.cpp:615]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: SchedulerRT::Add: added script element - id= 4214; time= 0 [iseRTScheduler.cpp:343]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: pDest->ExecuteDestination succeeded from Program ID = 49207 'Push Script for pocket control' with valNew = 'ALTE Servicemeldung^M ^M DB_H_LEQ0784289 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M HM-LC-Sw4-Ba-PCB NEQ0027554 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:30 (25.01.19 18:31)^M ^M Flur_unten_BWM_HmIP-SMI55 0014D8A98A143A : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M ' [iseDOMPrg.cpp:625]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: IseXmlRpc::GetInterfaceByID: interface name= CUxD for ID=12941 [iseXmlRpc.cpp:2549]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: IseXmlRpc::CallXmlrpcMethod: method =setValue params = {"CUX2801001:1","CMD_EXEC","logger -t script -p user.debug [ALCHY ALLINScript ENDE]"} result = "" [iseXmlRpc.cpp:2610]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteScript: id = 59657; ticks = 26 [iseRTScheduler.cpp:601]
Jan 25 18:31:46 ccu2 user.debug script: [ALCHY ALLINScript ENDE]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: IsePersist::ExecProcess = 'wget -q -O /dev/null '--post-data=ccuid=P_2487C748-EDF5-475C-B10E-5C570ECA9B96&push=ALTE%20Servicemeldung^M ^M DB_H_LEQ0784289%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:31%20(25.01.19%2018:31)^M ^M HM-LC-Sw4-Ba-PCB%20NEQ0027554%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:30%20(25.01.19%2018:31)^M ^M Flur_unten_BWM_HmIP-SMI55%200014D8A98A143A%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:31%20(25.01.19%2018:31)^M ^M %20' http://push.pocket-control.com:9325 &' returned 0 [iseDOMpersist.cpp:380]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteScript: id = 4214; ticks = 9 [iseRTScheduler.cpp:601]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 9000 [iseRTScheduler.cpp:481]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 9000 [iseRTScheduler.cpp:481]
Jan 25 18:31:46 ccu2 user.err rfd: UnifiedLanCommController::connect(): Could not connect.
Jan 25 18:31:46 ccu2 user.err rfd: LGWPortWrapper::keepAliveThreadFunction(): Cannot connect.
Jan 25 18:31:46 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:46 ccu2 user.debug rfd: asyncReconnect -> reconnect
Jan 25 18:31:50 ccu2 user.err rfd: LGWPortWrapper::ReadData(): Receive error
Jan 25 18:31:50 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:50 ccu2 user.debug rfd: LGWPortWrapper::asyncReconnect(): Reconnect already in progress.
Jan 25 18:31:50 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Trying to reconnect.
Jan 25 18:31:50 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Perform connect.
Jan 25 18:31:51 ccu2 user.info rfd: Lan Device Information: Protocol-Version: 1 Product-ID: Revilo-HM-LGW Firmware-Version: 0.0.2 Serial Number: MEQ0835478
Jan 25 18:31:51 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initialize coprocessor.
Jan 25 18:31:51 ccu2 user.debug rfd: CCU2CommController::improvedInit() - Coprocessor is in bootloader, going to start application.
Jan 25 18:31:51 ccu2 user.debug rfd: (MEQ0835478) CCU2CommController::handleIdentifyEvent(): Coprocessor entered application. Life is good.
Jan 25 18:31:52 ccu2 user.info rfd: (MEQ0835478) CCU2CommController::setCSMACAEnabled(): CSMA/CA disabled.
Jan 25 18:31:52 ccu2 user.debug rfd: (MEQ0835478) Response status: OK.
Jan 25 18:31:52 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initializing keepalives.
Jan 25 18:31:52 ccu2 user.debug rfd: LGWPortWrapper::connect(): Reconnected.
Jan 25 18:31:52 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Reconnect finished.
Jan 25 18:31:52 ccu2 user.info rfd: LanConnection::receive(): sock 14: Remote host closed connection.
Jan 25 18:31:52 ccu2 user.debug multimac: C> @176343: #3 TRX CMD=0B 00 01
Jan 25 18:31:52 ccu2 user.warn multimac: Bad cast: std::bad_cast
Jan 25 18:31:52 ccu2 user.debug multimac: A<: #25 TRX CMD=0B 00 01
Jan 25 18:31:52 ccu2 user.debug multimac: A>: #235 TRX CMD=0A
Jan 25 18:31:52 ccu2 user.debug multimac: MacController::OnDownstreamFrame(#235 TRX CMD=0A )
Jan 25 18:31:52 ccu2 user.debug multimac: C<: #76 TRX CMD=0A
Jan 25 18:31:52 ccu2 user.debug multimac: C< @176346: bin:FD 00 03 01 4C 0A 30 2D
Jan 25 18:31:53 ccu2 user.debug multimac: C> @176449: #76 TRX Response Ack 00
Jan 25 18:31:53 ccu2 user.debug multimac: A<: #235 TRX Response Ack 00
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 317 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 226 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 325 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 230 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 233 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueList=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').ValueList() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 305 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 220 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:54 ccu2 user.err rfd: UnifiedLanCommController::connect(): Could not connect.
Jan 25 18:31:54 ccu2 user.err rfd: LGWPortWrapper::keepAliveThreadFunction(): Cannot connect.
Jan 25 18:31:54 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:54 ccu2 user.debug rfd: asyncReconnect -> reconnect
Jan 25 18:31:54 ccu2 user.debug multimac: C<: #77 TRX GetDutyCycle
Jan 25 18:31:54 ccu2 user.debug multimac: C< @178179: bin:FD 00 03 01 4D 03 B6 18
Jan 25 18:31:54 ccu2 user.debug multimac: C> @178283: #77 TRX Response Ack 08
Jan 25 18:31:54 ccu2 user.debug multimac: SubsystemBidcos::CheckDutyCycleEventThreshold( 4.0, 4.0 ) = 0
Jan 25 18:31:55 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteScript: id = 57266; ticks = 67 [iseRTScheduler.cpp:601]
Jan 25 18:31:55 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 542000 [iseRTScheduler.cpp:481]
Jan 25 18:31:56 ccu2 auth.info sshd[3741]: Accepted password for root from 192.168.178.22 port 54509 ssh2