Ankündigung

Einklappen
Keine Ankündigung bisher.

Neuling braucht Hilfe bei Problembehebung in Smarthome (Errno 13,... )

Einklappen
X
 
  • Filter
  • Zeit
  • Anzeigen
Alles löschen
neue Beiträge

    #31
    Zitat von MotteX Beitrag anzeigen
    Blöde Frage aber brauche ich diesen SmarthomeNG Server-Prozess für meine Zwecke überhaupt ?
    Wenn Du das Plugin für die Helios einsetzen willst: Ja.

    /tom

    Kommentar


      #32
      Hm schade, dann weiß ich aktuell auch nicht mehr weiter. Da der automatische Start anscheinend nicht funktioniert. Obwohl ich komplett nach Anleitung vorgegangen bin. Also muss ich den Dienst abschießen und händisch neu starten.

      Da fällt mir noch was ein, ich Loge mich immer mit sudo su ein um das alles zu bearbeiten, bei der Anleitung wird jedoch ein User smarthome angelegt, könnte es vielleicht auch ein Rechteproblem sein ?

      Und warum kommt in der VISU nach einiger Zeit immer das kleine rote Dreieck oben rechts ?

      Code:
      2016-08-17 15:45:18,571 INFO     Main         Start SmartHome.py 1.1.1 -- smarthome.py:__init__:245
      2016-08-17 15:45:18,572 DEBUG    Main         Python 3.4.2 -- smarthome.py:__init__:246
      2016-08-17 15:45:18,573 INFO     Main         Init Scheduler -- scheduler.py:__init__:86
      2016-08-17 15:45:18,574 DEBUG    Scheduler    creating 5 workers -- scheduler.py:run:93
      2016-08-17 15:45:18,575 INFO     Main         Init Plugins -- smarthome.py:start:291
      2016-08-17 15:45:18,579 DEBUG    Main         Plugin: helios -- plugin.py:__init__:43
      2016-08-17 15:45:18,597 DEBUG    Main         Plugin: uzsu -- plugin.py:__init__:43
      2016-08-17 15:45:18,612 INFO     Main         Init UZSU -- __init__.py:__init__:62
      2016-08-17 15:45:18,613 DEBUG    Main         Plugin: ical -- plugin.py:__init__:43
      2016-08-17 15:45:18,615 DEBUG    Main         Plugin: visu -- plugin.py:__init__:43
      2016-08-17 15:45:18,630 INFO     Main         Init Items -- smarthome.py:start:297
      2016-08-17 15:45:18,663 DEBUG    Main         Item env.core: no type specified. -- item.py:__init__:242
      2016-08-17 15:45:18,675 DEBUG    Main         Item env.location: no type specified. -- item.py:__init__:242
      2016-08-17 15:45:18,681 DEBUG    Main         Item env.system: no type specified. -- item.py:__init__:242
      2016-08-17 15:45:18,682 DEBUG    Main         Item env: no type specified. -- item.py:__init__:242
      2016-08-17 15:45:18,761 DEBUG    Main         Item ventilation.testing: no type specified. -- item.py:__init__:242
      2016-08-17 15:45:18,762 DEBUG    Main         Item ventilation: no type specified. -- item.py:__init__:242
      2016-08-17 15:45:18,772 DEBUG    Main         Triggering ventilation.consumption_ventilators - by: Init source: None dest: None value: {'caller': 'Init', 'value': 0} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,773 DEBUG    Main         Triggering ventilation.airflow - by: Init source: None dest: None value: {'caller': 'Init', 'value': 0} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,774 DEBUG    Main         Triggering ventilation.air_exchange_rate - by: Init source: None dest: None value: {'caller': 'Init', 'value': 0} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,775 DEBUG    Main         Triggering ventilation.energy_loss - by: Init source: None dest: None value: {'caller': 'Init', 'value': 0} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,776 DEBUG    Main         Triggering ventilation.energy_saving - by: Init source: None dest: None value: {'caller': 'Init', 'value': 0} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,777 DEBUG    Main         Triggering ventilation.efficiency - by: Init source: None dest: None value: {'caller': 'Init', 'value': 0} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,778 DEBUG    Main         Triggering ventilation.device_error.current_error - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,778 DEBUG    Main         Triggering ventilation.error_handler.error_string.code - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,780 DEBUG    ventilation.device_error.current_error Item ventilation.device_error.current_error = test:test:test via Init None None -- item.py:__update:373
      2016-08-17 15:45:18,780 DEBUG    Main         Triggering ventilation.error_handler.error_string.description - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,781 WARNING  ventilation.error_handler.error_string.code Item ventilation.error_handler.error_string.code: problem evaluating self.parent.parent(): 'Item' object has no attribute 'parent' -- item.py:__run_eval:341
      2016-08-17 15:45:18,784 DEBUG    Main         Triggering ventilation.error_handler.error_string.cause - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,787 DEBUG    Main         Triggering ventilation.error_handler.error_string.solution - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,788 WARNING  ventilation.error_handler.error_string.cause Item ventilation.error_handler.error_string.cause: problem evaluating self.parent().split(':')[1]: 'Item' object has no attribute 'parent' -- item.py:__run_eval:341
      2016-08-17 15:45:18,789 DEBUG    Main         Triggering ventilation.error_handler.error_string - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,790 WARNING  ventilation.error_handler.error_string.solution Item ventilation.error_handler.error_string.solution: problem evaluating self.parent().split(':')[2]: 'Item' object has no attribute 'parent' -- item.py:__run_eval:341
      2016-08-17 15:45:18,792 DEBUG    Main         Triggering ventilation.error_handler - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:45:18,794 WARNING  ventilation.error_handler.error_string Item ventilation.error_handler.error_string: problem evaluating ("self.return_parent().conf['" + self.parent() + "']"): 'Item' object has no attribute 'parent' -- item.py:__run_eval:341
      2016-08-17 15:45:18,796 INFO     Main         Items: 80 -- smarthome.py:start:329
      2016-08-17 15:45:18,798 DEBUG    ventilation.error_handler Item ventilation.error_handler = e1 via Init None None -- item.py:__update:373
      2016-08-17 15:45:18,800 INFO     Main         Start Logics -- logic.py:__init__:33
      2016-08-17 15:45:18,802 DEBUG    Main         Reading Logics from /usr/local/smarthome/lib/env/logic_conf -- logic.py:_read_logics:64
      2016-08-17 15:45:18,806 DEBUG    Main         Reading Logics from /usr/local/smarthome/etc/logic.conf -- logic.py:_read_logics:64
      2016-08-17 15:45:18,809 DEBUG    Main         Logic: env_loc -- logic.py:__init__:44
      2016-08-17 15:45:18,828 DEBUG    Main         Logic: booster_logic -- logic.py:__init__:44
      2016-08-17 15:45:18,836 DEBUG    Main         Logic: fanspeed_uzsu_logic -- logic.py:__init__:44
      2016-08-17 15:45:18,844 DEBUG    Main         Logic: env_init -- logic.py:__init__:44
      2016-08-17 15:45:18,848 DEBUG    Main         Logic: env_daily -- logic.py:__init__:44
      2016-08-17 15:45:18,859 DEBUG    Main         env_daily next time: 2016-08-18 06:00:00+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:45:18,860 DEBUG    Main         Logic: env_stat -- logic.py:__init__:44
      2016-08-17 15:45:18,865 DEBUG    Main         env_stat next time: 2016-08-17 15:45:31+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:45:18,867 INFO     Main         Start Plugins -- plugin.py:start:65
      2016-08-17 15:45:18,868 DEBUG    Main         Starting helios Plugin -- plugin.py:start:67
      2016-08-17 15:45:18,869 DEBUG    helios       Helios: Connecting... -- __init__.py:connect:102
      2016-08-17 15:45:18,870 DEBUG    Main         Starting uzsu Plugin -- plugin.py:start:67
      2016-08-17 15:45:18,872 DEBUG    Main         Starting ical Plugin -- plugin.py:start:67
      2016-08-17 15:45:18,873 DEBUG    Main         Starting visu Plugin -- plugin.py:start:67
      2016-08-17 15:45:18,878 DEBUG    helios       Helios next time: 2016-08-17 15:45:28+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:45:19,114 DEBUG    Connections  WebSocket: binding to 192.168.178.31:2424 (TCP) -- connection.py:connect:160
      2016-08-17 15:45:24,129 DEBUG    env_init     Item env.core.version = 1.1.1 via Logic None None -- item.py:__update:373
      2016-08-17 15:45:24,131 DEBUG    env_loc      Item env.location.sunrise = 2016-08-18 05:54:01.065441+02:00 via Logic None None -- item.py:__update:373
      2016-08-17 15:45:24,135 DEBUG    env_init     Item env.core.start = 2016-08-17 15:45:24.133260+02:00 via Logic None None -- item.py:__update:373
      2016-08-17 15:45:24,168 DEBUG    sh.gc        Garbage collector: collected 0 objects. -- smarthome.py:_garbage_collection:522
      2016-08-17 15:45:24,178 DEBUG    env_loc      Item env.location.sunset = 2016-08-17 20:27:13.076732+02:00 via Logic None None -- item.py:__update:373
      2016-08-17 15:45:24,182 DEBUG    env_init     Item env.system.name = raspberrypi via Logic None None -- item.py:__update:373
      2016-08-17 15:45:24,206 DEBUG    env_loc      Item env.location.moonrise = 2016-08-17 19:48:44.880586+02:00 via Logic None None -- item.py:__update:373
      2016-08-17 15:45:24,223 DEBUG    sh.gc        Object references: 11411 -- smarthome.py:_maintenance:514
      2016-08-17 15:45:24,231 DEBUG    env_init     Item env.system.start = 2016-08-17 15:26:14.229849+02:00 via Logic None None -- item.py:__update:373
      2016-08-17 15:45:24,236 DEBUG    env_loc      Item env.location.moonset = 2016-08-18 05:49:37.113309+02:00 via Logic None None -- item.py:__update:373
      2016-08-17 15:45:24,242 DEBUG    env_loc      Item env.location.moonphase = 4 via Logic None None -- item.py:__update:373
      2016-08-17 15:45:24,251 DEBUG    env_loc      Item env.location.day = True via Logic None None -- item.py:__update:373
      2016-08-17 15:45:24,636 DEBUG    Scheduler    env_loc next time: 2016-08-17 16:15:24+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:45:24,640 DEBUG    Scheduler    sh.gc next time: 2016-08-18 02:04:00+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:45:28,149 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:45:28,150 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:45:28,224 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:28,240 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:28,241 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:45:28,241 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:45:28,312 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:28,328 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA9 0x1D' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:28,328 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA9|10101001|169 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:45:28,329 DEBUG    Helios       Item ventilation.exhaust_temp = 23 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:28,330 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:45:28,401 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:28,417 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:28,417 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:45:28,418 DEBUG    Helios       Item ventilation.booster.built_in.mode = 1 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:28,419 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:45:28,489 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:28,506 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:28,506 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:45:28,506 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:45:28,577 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:28,593 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:28,594 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:45:28,594 DEBUG    Helios       Item ventilation.min_fanspeed = 4 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:28,595 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:45:28,655 DEBUG    Scheduler    Helios next time: 2016-08-17 15:46:28+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:45:28,666 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:28,682 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:28,683 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:45:28,683 DEBUG    Helios       Item ventilation.clean_filter = 4 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:28,684 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:45:28,755 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:28,771 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:28,771 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:45:28,772 DEBUG    Helios       Item ventilation.inside_temp = 24 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:28,773 DEBUG    Helios       Triggering ventilation.energy_loss - by: Helios source: None dest: None value: {'source': 'ventilation.inside_temp', 'v -- scheduler.py:trigger:164
      2016-08-17 15:45:28,774 DEBUG    Helios       Triggering ventilation.efficiency - by: Helios source: None dest: None value: {'source': 'ventilation.inside_temp', 'v -- scheduler.py:trigger:164
      2016-08-17 15:45:28,775 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:45:28,846 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:28,863 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:28,864 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:45:28,864 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:45:28,936 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:28,953 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x1F 0x89' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:28,954 DEBUG    Helios       Value for fanspeed (0x29) received: 0x1F|00011111|31 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:45:28,955 DEBUG    Helios       Item ventilation.fanspeed = 5 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:28,957 DEBUG    Helios       Triggering ventilation.consumption_ventilators - by: Helios source: None dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:45:28,958 DEBUG    Helios       Triggering ventilation.airflow - by: Helios source: None dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:45:28,960 DEBUG    ventilation.consumption_ventilators Item ventilation.consumption_ventilators = 92 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:45:28,961 DEBUG    Helios       Triggering ventilation.air_exchange_rate - by: Helios source: None dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:45:28,963 DEBUG    ventilation.airflow Item ventilation.airflow = 270 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:45:28,965 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:45:28,967 DEBUG    ventilation.air_exchange_rate Item ventilation.air_exchange_rate = 0.49 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:45:28,969 DEBUG    ventilation.airflow Triggering ventilation.energy_loss - by: Eval source: ventilation.fanspeed dest: None value: {'source': 'ventilation.airflow', 'value -- scheduler.py:trigger:164
      2016-08-17 15:45:28,972 DEBUG    ventilation.airflow Triggering ventilation.energy_saving - by: Eval source: ventilation.fanspeed dest: None value: {'source': 'ventilation.airflow', 'value -- scheduler.py:trigger:164
      2016-08-17 15:45:28,974 DEBUG    ventilation.energy_loss Item ventilation.energy_loss = 1852 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:45:29,047 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:29,063 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:29,064 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:45:29,065 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:45:29,153 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:29,175 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:29,176 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:45:29,178 DEBUG    Helios       Item ventilation.max_fanspeed = 8 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:29,179 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:45:29,259 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:29,276 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:29,277 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:45:29,279 DEBUG    Helios       Item ventilation.fan_in_percent = 100 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:29,281 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:45:29,366 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:29,383 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:29,384 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:45:29,385 DEBUG    Helios       Item ventilation.bypass_temp = 5 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:29,387 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:45:29,471 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:29,488 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:29,489 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:45:29,491 DEBUG    Helios       Item ventilation.fan_out_percent = 100 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:29,493 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:45:29,578 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:29,595 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:29,596 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:45:29,597 DEBUG    Helios       Item ventilation.power_state = 1 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:29,599 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:45:29,768 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:29,785 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:29,786 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:45:29,786 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:45:29,858 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:29,875 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:29,876 DEBUG    Helios       Value for boost_status (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:45:29,876 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:45:29,948 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:29,965 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x32 0x95 0x08' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:29,966 DEBUG    Helios       Value for outside_temp (0x32) received: 0x95|10010101|149 --> converted = 16 -- __init__.py:readValue:399
      2016-08-17 15:45:29,967 DEBUG    Helios       Item ventilation.outside_temp = 16 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:29,969 DEBUG    Helios       Triggering ventilation.energy_saving - by: Helios source: None dest: None value: {'source': 'ventilation.outside_temp', ' -- scheduler.py:trigger:164
      2016-08-17 15:45:29,970 DEBUG    Helios       Triggering ventilation.efficiency - by: Helios source: None dest: None value: {'source': 'ventilation.outside_temp', ' -- scheduler.py:trigger:164
      2016-08-17 15:45:29,972 DEBUG    ventilation.energy_saving Item ventilation.energy_saving = -1235 via Eval ventilation.outside_temp None -- item.py:__update:373
      2016-08-17 15:45:29,973 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:45:29,975 DEBUG    ventilation.efficiency Item ventilation.efficiency = -200 via Eval ventilation.outside_temp None -- item.py:__update:373
      2016-08-17 15:45:30,048 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:30,065 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:30,066 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      2016-08-17 15:45:30,068 DEBUG    Helios       Item ventilation.incoming_temp = 17 via Helios None None -- item.py:__update:373
      2016-08-17 15:45:30,069 DEBUG    Helios       Triggering ventilation.energy_loss - by: Helios source: None dest: None value: {'source': 'ventilation.incoming_temp',  -- scheduler.py:trigger:164
      2016-08-17 15:45:30,070 DEBUG    Helios       Triggering ventilation.energy_saving - by: Helios source: None dest: None value: {'source': 'ventilation.incoming_temp',  -- scheduler.py:trigger:164
      2016-08-17 15:45:30,073 DEBUG    ventilation.energy_loss Item ventilation.energy_loss = 540 via Eval ventilation.incoming_temp None -- item.py:__update:373
      2016-08-17 15:45:30,073 DEBUG    Helios       Triggering ventilation.efficiency - by: Helios source: None dest: None value: {'source': 'ventilation.incoming_temp',  -- scheduler.py:trigger:164
      2016-08-17 15:45:30,075 DEBUG    ventilation.energy_saving Item ventilation.energy_saving = 77 via Eval ventilation.incoming_temp None -- item.py:__update:373
      2016-08-17 15:45:30,080 DEBUG    ventilation.efficiency Item ventilation.efficiency = 12 via Eval ventilation.incoming_temp None -- item.py:__update:373
      2016-08-17 15:45:31,197 DEBUG    env_stat     Item env.core.threads = 7 via Logic None None -- item.py:__update:373
      2016-08-17 15:45:31,201 DEBUG    env_stat     Item env.core.memory = 12775424 via Logic None None -- item.py:__update:373
      2016-08-17 15:45:31,204 DEBUG    env_stat     Item env.system.load = 0.04 via Logic None None -- item.py:__update:373
      2016-08-17 15:45:31,206 DEBUG    env_stat     Item env.location.moonlight = 99 via Logic None None -- item.py:__update:373
      2016-08-17 15:45:31,667 DEBUG    Scheduler    env_stat next time: 2016-08-17 15:50:31+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:46:28,356 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:46:28,357 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:46:28,478 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:28,496 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:28,497 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:46:28,497 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:46:28,569 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:28,586 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA9 0x1D' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:28,587 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA9|10101001|169 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:46:28,587 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:46:28,659 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:28,676 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:28,677 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:46:28,678 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:46:28,749 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:28,766 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:28,767 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:46:28,768 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:46:28,839 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:28,856 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:28,859 DEBUG    Scheduler    Helios next time: 2016-08-17 15:47:28+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:46:28,860 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:46:28,861 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:46:28,933 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:28,950 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:28,951 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:46:28,952 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:46:29,023 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:29,041 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:29,041 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:46:29,042 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:46:29,114 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:29,131 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:29,132 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:46:29,132 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:46:29,204 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:29,221 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x1F 0x89' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:29,222 DEBUG    Helios       Value for fanspeed (0x29) received: 0x1F|00011111|31 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:46:29,223 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:46:29,294 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:29,311 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:29,312 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:46:29,313 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:46:29,408 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:29,425 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:29,426 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:46:29,427 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:46:29,514 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:29,532 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:29,533 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:46:29,533 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:46:29,621 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:29,638 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:29,639 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:46:29,640 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:46:29,727 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:29,745 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:29,746 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:46:29,746 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:46:29,834 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:29,851 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:29,852 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:46:29,853 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:46:29,939 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:29,957 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:29,957 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:46:29,958 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:46:30,046 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:30,063 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:30,064 DEBUG    Helios       Value for boost_status (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:46:30,065 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:46:30,136 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:30,153 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x32 0x95 0x08' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:30,154 DEBUG    Helios       Value for outside_temp (0x32) received: 0x95|10010101|149 --> converted = 16 -- __init__.py:readValue:399
      2016-08-17 15:46:30,155 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:46:30,226 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:30,244 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:46:30,244 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      2016-08-17 15:46:46,728 DEBUG    Main         WebSocket: incoming connection from 192.168.178.38:57018 to 192.168.178.31:2424 -- connection.py:accept:187
      2016-08-17 15:46:46,730 DEBUG    Main         rfc6455 Handshake -- __init__.py:rfc6455_handshake:392
      2016-08-17 15:46:47,011 DEBUG    Main         192.168.178.38:57018 sent '{"cmd":"proto","ver":3}' -- __init__.py:json_parse:273
      2016-08-17 15:46:47,017 DEBUG    Main         192.168.178.38:57018 sent '{"cmd":"monitor","items":["ventilation.outside_temp","ventilation.inside_temp","ventilation.exhaust_temp","ventilation.incoming_temp","ventilation.fanspeed","ventilation.booster.logics.boost_duration","ventilation.clean_filter","ventilation.power_state","ventilation.bypass_disabled","ventilation.fanspeed.uzsu_timer","ventilation.booster.built_in.on_switch","ventilation.booster.logics.switch","ventilation.boost_remaining_a","ventilation.error_handler.error_string.code","ventilation.error_handler.error_string.description","ventilation.error_handler.error_string.cause","ventilation.error_handler.error_string.solution","ventilation.min_fanspeed","ventilation.max_fanspeed","ventilation.bypass_temp","ventilation.device_error","ventilation.fan_in_on_off","ventilation.fan_in_percent","ventilation.fan_out_on_off","ventilation.fan_out_percent","ventilation.booster.built_in.mode","ventilation.airflow","ventilation.air_exchange_rate","ventilation.energy_loss","ventilation.energy_saving","ventilation.efficiency","ventilation.consumption_ventilators","ventilation.booster.logics.fireplace_duration","ventilation.booster.logics.level"]}' -- __init__.py:json_parse:273
      2016-08-17 15:46:47,110 DEBUG    Main         192.168.178.38:57018 sent '{"cmd":"item","id":"ventilation.booster.logics.boost_duration","val":2700}' -- __init__.py:json_parse:273
      2016-08-17 15:46:47,147 DEBUG    Main         192.168.178.38:57018 sent '{"cmd":"item","id":"ventilation.booster.logics.boost_duration","val":2700}' -- __init__.py:json_parse:273
      2016-08-17 15:46:47,238 DEBUG    Main         192.168.178.38:57018 sent '{"cmd":"item","id":"ventilation.booster.logics.fireplace_duration","val":0}' -- __init__.py:json_parse:273
      2016-08-17 15:46:47,245 DEBUG    Main         192.168.178.38:57018 sent '{"cmd":"item","id":"ventilation.booster.logics.fireplace_duration","val":0}' -- __init__.py:json_parse:273
      2016-08-17 15:46:50,821 DEBUG    Main         192.168.178.38:57018 sent '{"cmd":"item","id":"ventilation.fanspeed","val":"6"}' -- __init__.py:json_parse:273
      2016-08-17 15:46:50,823 DEBUG    Main         Item ventilation.fanspeed = 6 via Visu 192.168.178.38:57018 None -- item.py:__update:373
      2016-08-17 15:46:50,913 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x20 0x29 0x3F 0xB8' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:50,914 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x10 0x29 0x3F 0xA8' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:50,915 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x11 0x29 0x3F 0xA9' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:50,915 DEBUG    Main         Helios: Sending telegram '0xA9' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:50,916 DEBUG    Main         Triggering ventilation.consumption_ventilators - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:46:50,917 DEBUG    Main         Triggering ventilation.airflow - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:46:50,919 DEBUG    ventilation.consumption_ventilators Item ventilation.consumption_ventilators = 130 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:46:50,920 DEBUG    Main         Triggering ventilation.air_exchange_rate - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:46:50,923 DEBUG    ventilation.airflow Item ventilation.airflow = 305 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:46:50,927 DEBUG    ventilation.air_exchange_rate Item ventilation.air_exchange_rate = 0.56 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:46:50,932 DEBUG    ventilation.airflow Triggering ventilation.energy_loss - by: Eval source: ventilation.fanspeed dest: None value: {'source': 'ventilation.airflow', 'value -- scheduler.py:trigger:164
      2016-08-17 15:46:50,933 DEBUG    ventilation.airflow Triggering ventilation.energy_saving - by: Eval source: ventilation.fanspeed dest: None value: {'source': 'ventilation.airflow', 'value -- scheduler.py:trigger:164
      2016-08-17 15:46:50,936 DEBUG    ventilation.energy_loss Item ventilation.energy_loss = 610 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:46:50,939 DEBUG    ventilation.energy_saving Item ventilation.energy_saving = 87 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:46:54,128 DEBUG    Main         192.168.178.38:57018 sent '{"cmd":"item","id":"ventilation.fanspeed","val":"5"}' -- __init__.py:json_parse:273
      2016-08-17 15:46:54,131 DEBUG    Main         Item ventilation.fanspeed = 5 via Visu 192.168.178.38:57018 None -- item.py:__update:373
      2016-08-17 15:46:54,208 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x20 0x29 0x1F 0x98' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:54,209 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x10 0x29 0x1F 0x88' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:54,209 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x11 0x29 0x1F 0x89' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:54,210 DEBUG    Main         Helios: Sending telegram '0x89' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:54,211 DEBUG    Main         Triggering ventilation.consumption_ventilators - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:46:54,212 DEBUG    Main         Triggering ventilation.airflow - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:46:54,214 DEBUG    ventilation.consumption_ventilators Item ventilation.consumption_ventilators = 92 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:46:54,215 DEBUG    Main         Triggering ventilation.air_exchange_rate - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:46:54,217 DEBUG    ventilation.airflow Item ventilation.airflow = 270 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:46:54,222 DEBUG    ventilation.air_exchange_rate Item ventilation.air_exchange_rate = 0.49 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:46:54,224 DEBUG    ventilation.airflow Triggering ventilation.energy_loss - by: Eval source: ventilation.fanspeed dest: None value: {'source': 'ventilation.airflow', 'value -- scheduler.py:trigger:164
      2016-08-17 15:46:54,227 DEBUG    ventilation.airflow Triggering ventilation.energy_saving - by: Eval source: ventilation.fanspeed dest: None value: {'source': 'ventilation.airflow', 'value -- scheduler.py:trigger:164
      2016-08-17 15:46:54,229 DEBUG    ventilation.energy_loss Item ventilation.energy_loss = 540 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:46:54,232 DEBUG    ventilation.energy_saving Item ventilation.energy_saving = 77 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:46:55,413 DEBUG    Main         192.168.178.38:57018 sent '{"cmd":"item","id":"ventilation.fanspeed","val":"4"}' -- __init__.py:json_parse:273
      2016-08-17 15:46:55,415 DEBUG    Main         Item ventilation.fanspeed = 4 via Visu 192.168.178.38:57018 None -- item.py:__update:373
      2016-08-17 15:46:55,488 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x20 0x29 0x0F 0x88' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:55,489 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x10 0x29 0x0F 0x78' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:55,490 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x11 0x29 0x0F 0x79' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:55,491 DEBUG    Main         Helios: Sending telegram '0x79' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:55,492 DEBUG    Main         Triggering ventilation.consumption_ventilators - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:46:55,493 DEBUG    Main         Triggering ventilation.airflow - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:46:55,495 DEBUG    ventilation.consumption_ventilators Item ventilation.consumption_ventilators = 72 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:46:55,496 DEBUG    Main         Triggering ventilation.air_exchange_rate - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:46:55,498 DEBUG    ventilation.airflow Item ventilation.airflow = 240 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:46:55,502 DEBUG    ventilation.air_exchange_rate Item ventilation.air_exchange_rate = 0.44 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:46:55,505 DEBUG    ventilation.airflow Triggering ventilation.energy_loss - by: Eval source: ventilation.fanspeed dest: None value: {'source': 'ventilation.airflow', 'value -- scheduler.py:trigger:164
      2016-08-17 15:46:55,508 DEBUG    ventilation.airflow Triggering ventilation.energy_saving - by: Eval source: ventilation.fanspeed dest: None value: {'source': 'ventilation.airflow', 'value -- scheduler.py:trigger:164
      2016-08-17 15:46:55,510 DEBUG    ventilation.energy_loss Item ventilation.energy_loss = 480 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:46:55,513 DEBUG    ventilation.energy_saving Item ventilation.energy_saving = 69 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:46:58,932 DEBUG    Main         192.168.178.38:57018 sent '{"cmd":"item","id":"ventilation.fanspeed","val":"5"}' -- __init__.py:json_parse:273
      2016-08-17 15:46:58,935 DEBUG    Main         Item ventilation.fanspeed = 5 via Visu 192.168.178.38:57018 None -- item.py:__update:373
      2016-08-17 15:46:59,012 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x20 0x29 0x1F 0x98' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:59,013 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x10 0x29 0x1F 0x88' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:59,014 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x11 0x29 0x1F 0x89' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:59,015 DEBUG    Main         Helios: Sending telegram '0x89' -- __init__.py:_sendTelegram:152
      2016-08-17 15:46:59,016 DEBUG    Main         Triggering ventilation.consumption_ventilators - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:46:59,016 DEBUG    Main         Triggering ventilation.airflow - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:46:59,019 DEBUG    ventilation.consumption_ventilators Item ventilation.consumption_ventilators = 92 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:46:59,022 DEBUG    ventilation.airflow Item ventilation.airflow = 270 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:46:59,020 DEBUG    Main         Triggering ventilation.air_exchange_rate - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:46:59,026 DEBUG    ventilation.airflow Triggering ventilation.energy_loss - by: Eval source: ventilation.fanspeed dest: None value: {'source': 'ventilation.airflow', 'value -- scheduler.py:trigger:164
      2016-08-17 15:46:59,029 DEBUG    ventilation.air_exchange_rate Item ventilation.air_exchange_rate = 0.49 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:46:59,032 DEBUG    ventilation.energy_loss Item ventilation.energy_loss = 540 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:46:59,030 DEBUG    ventilation.airflow Triggering ventilation.energy_saving - by: Eval source: ventilation.fanspeed dest: None value: {'source': 'ventilation.airflow', 'value -- scheduler.py:trigger:164
      2016-08-17 15:46:59,038 DEBUG    ventilation.energy_saving Item ventilation.energy_saving = 77 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:47:03,803 DEBUG    Main         192.168.178.38:57018 sent '{"cmd":"item","id":"ventilation.fanspeed","val":"4"}' -- __init__.py:json_parse:273
      2016-08-17 15:47:03,805 DEBUG    Main         Item ventilation.fanspeed = 4 via Visu 192.168.178.38:57018 None -- item.py:__update:373
      2016-08-17 15:47:03,885 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x20 0x29 0x0F 0x88' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:03,886 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x10 0x29 0x0F 0x78' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:03,887 DEBUG    Main         Helios: Sending telegram '0x01 0x2F 0x11 0x29 0x0F 0x79' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:03,888 DEBUG    Main         Helios: Sending telegram '0x79' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:03,889 DEBUG    Main         Triggering ventilation.consumption_ventilators - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:47:03,890 DEBUG    Main         Triggering ventilation.airflow - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:47:03,893 DEBUG    ventilation.consumption_ventilators Item ventilation.consumption_ventilators = 72 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:47:03,893 DEBUG    Main         Triggering ventilation.air_exchange_rate - by: Visu source: 192.168.178.38:57018 dest: None value: {'source': 'ventilation.fanspeed', 'valu -- scheduler.py:trigger:164
      2016-08-17 15:47:03,895 DEBUG    ventilation.airflow Item ventilation.airflow = 240 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:47:03,900 DEBUG    ventilation.air_exchange_rate Item ventilation.air_exchange_rate = 0.44 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:47:03,903 DEBUG    ventilation.airflow Triggering ventilation.energy_loss - by: Eval source: ventilation.fanspeed dest: None value: {'source': 'ventilation.airflow', 'value -- scheduler.py:trigger:164
      2016-08-17 15:47:03,906 DEBUG    ventilation.airflow Triggering ventilation.energy_saving - by: Eval source: ventilation.fanspeed dest: None value: {'source': 'ventilation.airflow', 'value -- scheduler.py:trigger:164
      2016-08-17 15:47:03,908 DEBUG    ventilation.energy_loss Item ventilation.energy_loss = 480 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:47:03,912 DEBUG    ventilation.energy_saving Item ventilation.energy_saving = 69 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:47:10,422 DEBUG    Main         WebSocket: closing connection to 192.168.178.38:57018. -- __init__.py:rfc6455_parse:411
      2016-08-17 15:47:10,423 DEBUG    Main         WebSocketHandler: closing socket 192.168.178.38:57018 -- connection.py:close:309
      2016-08-17 15:47:28,058 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:47:28,059 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:47:28,149 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:28,166 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:28,167 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:47:28,168 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:47:28,239 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:28,256 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA8 0x1C' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:28,257 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA8|10101000|168 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:47:28,258 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:47:28,329 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:28,347 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:28,347 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:47:28,348 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:47:28,498 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:28,515 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:28,516 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:47:28,517 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:47:28,563 DEBUG    Scheduler    Helios next time: 2016-08-17 15:48:28+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:47:28,588 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:28,605 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:28,606 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:47:28,607 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:47:28,678 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:28,695 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:28,696 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:47:28,697 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:47:28,768 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:28,786 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:28,786 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:47:28,787 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:47:28,858 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:28,876 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:28,876 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:47:28,877 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:47:28,949 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:28,966 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x0F 0x79' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:28,967 DEBUG    Helios       Value for fanspeed (0x29) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:47:28,967 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:47:29,039 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:29,056 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:29,057 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:47:29,058 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:47:29,129 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:29,146 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:29,147 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:47:29,148 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:47:29,219 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:29,236 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:29,237 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:47:29,238 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:47:29,309 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:29,327 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:29,327 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:47:29,328 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:47:29,399 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:29,417 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:29,418 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:47:29,418 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:47:29,490 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:29,507 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:29,508 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:47:29,509 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:47:29,580 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:29,597 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:29,598 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:47:29,599 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:47:29,670 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:29,687 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:29,688 DEBUG    Helios       Value for boost_status (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:47:29,689 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:47:29,760 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:31,406 ERROR    Helios       Helios: No valid value for 'outside_temp' from ventilation system received. -- __init__.py:readValue:403
      2016-08-17 15:47:31,408 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:47:31,480 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:47:31,497 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:47:31,498 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      2016-08-17 15:48:28,255 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:48:28,256 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:48:28,377 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:28,394 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:28,395 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:48:28,396 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:48:28,467 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:28,484 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA8 0x1C' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:28,485 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA8|10101000|168 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:48:28,486 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:48:28,557 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:28,574 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:28,575 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:48:28,576 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:48:28,647 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:28,664 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:28,665 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:48:28,666 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:48:28,737 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:28,755 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:28,757 DEBUG    Scheduler    Helios next time: 2016-08-17 15:49:28+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:48:28,758 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:48:28,759 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:48:28,831 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:28,849 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:28,849 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:48:28,850 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:48:28,922 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:28,939 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:28,940 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:48:28,940 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:48:29,012 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:29,029 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:29,030 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:48:29,031 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:48:29,102 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:29,119 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x0F 0x79' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:29,120 DEBUG    Helios       Value for fanspeed (0x29) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:48:29,121 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:48:29,192 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:29,210 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:29,210 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:48:29,211 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:48:29,283 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:29,301 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:29,302 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:48:29,302 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:48:29,374 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:29,391 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:29,392 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:48:29,393 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:48:29,464 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:29,481 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:29,482 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:48:29,483 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:48:29,554 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:29,571 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:29,572 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:48:29,573 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:48:29,644 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:29,661 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:29,662 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:48:29,663 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:48:29,735 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:29,752 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:29,752 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:48:29,753 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:48:29,825 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:29,842 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:29,843 DEBUG    Helios       Value for boost_status (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:48:29,843 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:48:29,915 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:29,932 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x32 0x95 0x08' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:29,933 DEBUG    Helios       Value for outside_temp (0x32) received: 0x95|10010101|149 --> converted = 16 -- __init__.py:readValue:399
      2016-08-17 15:48:29,934 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:48:30,005 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:48:30,022 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:48:30,023 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      Code:
      2016-08-17 15:35:58,751 INFO     Main         Start SmartHome.py 1.1.1 -- smarthome.py:__init__:245
      2016-08-17 15:35:58,752 DEBUG    Main         Python 3.4.2 -- smarthome.py:__init__:246
      2016-08-17 15:35:58,753 INFO     Main         Init Scheduler -- scheduler.py:__init__:86
      2016-08-17 15:35:58,754 DEBUG    Scheduler    creating 5 workers -- scheduler.py:run:93
      2016-08-17 15:35:58,755 INFO     Main         Init Plugins -- smarthome.py:start:291
      2016-08-17 15:35:58,758 DEBUG    Main         Plugin: helios -- plugin.py:__init__:43
      2016-08-17 15:35:58,778 DEBUG    Main         Plugin: uzsu -- plugin.py:__init__:43
      2016-08-17 15:35:58,791 INFO     Main         Init UZSU -- __init__.py:__init__:62
      2016-08-17 15:35:58,792 DEBUG    Main         Plugin: ical -- plugin.py:__init__:43
      2016-08-17 15:35:58,794 DEBUG    Main         Plugin: visu -- plugin.py:__init__:43
      2016-08-17 15:35:58,809 INFO     Main         Init Items -- smarthome.py:start:297
      2016-08-17 15:35:58,843 DEBUG    Main         Item env.core: no type specified. -- item.py:__init__:242
      2016-08-17 15:35:58,855 DEBUG    Main         Item env.location: no type specified. -- item.py:__init__:242
      2016-08-17 15:35:58,860 DEBUG    Main         Item env.system: no type specified. -- item.py:__init__:242
      2016-08-17 15:35:58,861 DEBUG    Main         Item env: no type specified. -- item.py:__init__:242
      2016-08-17 15:35:58,940 DEBUG    Main         Item ventilation.testing: no type specified. -- item.py:__init__:242
      2016-08-17 15:35:58,941 DEBUG    Main         Item ventilation: no type specified. -- item.py:__init__:242
      2016-08-17 15:35:58,951 DEBUG    Main         Triggering ventilation.consumption_ventilators - by: Init source: None dest: None value: {'caller': 'Init', 'value': 0} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,951 DEBUG    Main         Triggering ventilation.airflow - by: Init source: None dest: None value: {'caller': 'Init', 'value': 0} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,952 DEBUG    Main         Triggering ventilation.air_exchange_rate - by: Init source: None dest: None value: {'caller': 'Init', 'value': 0} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,953 DEBUG    Main         Triggering ventilation.energy_loss - by: Init source: None dest: None value: {'caller': 'Init', 'value': 0} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,954 DEBUG    Main         Triggering ventilation.energy_saving - by: Init source: None dest: None value: {'caller': 'Init', 'value': 0} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,955 DEBUG    Main         Triggering ventilation.efficiency - by: Init source: None dest: None value: {'caller': 'Init', 'value': 0} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,956 DEBUG    Main         Triggering ventilation.device_error.current_error - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,957 DEBUG    Main         Triggering ventilation.error_handler.error_string.code - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,959 DEBUG    ventilation.device_error.current_error Item ventilation.device_error.current_error = test:test:test via Init None None -- item.py:__update:373
      2016-08-17 15:35:58,959 DEBUG    Main         Triggering ventilation.error_handler.error_string.description - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,960 WARNING  ventilation.error_handler.error_string.code Item ventilation.error_handler.error_string.code: problem evaluating self.parent.parent(): 'Item' object has no attribute 'parent' -- item.py:__run_eval:341
      2016-08-17 15:35:58,961 DEBUG    Main         Triggering ventilation.error_handler.error_string.cause - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,963 DEBUG    Main         Triggering ventilation.error_handler.error_string.solution - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,963 WARNING  ventilation.error_handler.error_string.cause Item ventilation.error_handler.error_string.cause: problem evaluating self.parent().split(':')[1]: 'Item' object has no attribute 'parent' -- item.py:__run_eval:341
      2016-08-17 15:35:58,964 DEBUG    Main         Triggering ventilation.error_handler.error_string - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,965 WARNING  ventilation.error_handler.error_string.solution Item ventilation.error_handler.error_string.solution: problem evaluating self.parent().split(':')[2]: 'Item' object has no attribute 'parent' -- item.py:__run_eval:341
      2016-08-17 15:35:58,966 DEBUG    Main         Triggering ventilation.error_handler - by: Init source: None dest: None value: {'caller': 'Init', 'value': ''} -- scheduler.py:trigger:164
      2016-08-17 15:35:58,966 WARNING  ventilation.error_handler.error_string Item ventilation.error_handler.error_string: problem evaluating ("self.return_parent().conf['" + self.parent() + "']"): 'Item' object has no attribute 'parent' -- item.py:__run_eval:341
      2016-08-17 15:35:58,968 INFO     Main         Items: 80 -- smarthome.py:start:329
      2016-08-17 15:35:58,969 DEBUG    ventilation.error_handler Item ventilation.error_handler = e1 via Init None None -- item.py:__update:373
      2016-08-17 15:35:58,970 INFO     Main         Start Logics -- logic.py:__init__:33
      2016-08-17 15:35:58,971 DEBUG    Main         Reading Logics from /usr/local/smarthome/lib/env/logic_conf -- logic.py:_read_logics:64
      2016-08-17 15:35:58,973 DEBUG    Main         Reading Logics from /usr/local/smarthome/etc/logic.conf -- logic.py:_read_logics:64
      2016-08-17 15:35:58,974 DEBUG    Main         Logic: env_stat -- logic.py:__init__:44
      2016-08-17 15:35:58,985 DEBUG    Main         env_stat next time: 2016-08-17 15:36:09+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:35:58,986 DEBUG    Main         Logic: env_daily -- logic.py:__init__:44
      2016-08-17 15:35:58,991 DEBUG    Main         env_daily next time: 2016-08-18 06:00:00+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:35:58,992 DEBUG    Main         Logic: booster_logic -- logic.py:__init__:44
      2016-08-17 15:35:58,996 DEBUG    Main         Logic: env_loc -- logic.py:__init__:44
      2016-08-17 15:35:58,998 DEBUG    Main         Logic: env_init -- logic.py:__init__:44
      2016-08-17 15:35:59,000 DEBUG    Main         Logic: fanspeed_uzsu_logic -- logic.py:__init__:44
      2016-08-17 15:35:59,005 INFO     Main         Start Plugins -- plugin.py:start:65
      2016-08-17 15:35:59,006 DEBUG    Main         Starting helios Plugin -- plugin.py:start:67
      2016-08-17 15:35:59,007 DEBUG    helios       Helios: Connecting... -- __init__.py:connect:102
      2016-08-17 15:35:59,007 DEBUG    Main         Starting uzsu Plugin -- plugin.py:start:67
      2016-08-17 15:35:59,008 DEBUG    Main         Starting ical Plugin -- plugin.py:start:67
      2016-08-17 15:35:59,009 DEBUG    Main         Starting visu Plugin -- plugin.py:start:67
      2016-08-17 15:35:59,013 DEBUG    helios       Helios next time: 2016-08-17 15:36:14+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:35:59,276 DEBUG    Connections  WebSocket: binding to 192.168.178.31:2424 (TCP) -- connection.py:connect:160
      2016-08-17 15:36:04,290 DEBUG    env_init     Item env.core.version = 1.1.1 via Logic None None -- item.py:__update:373
      2016-08-17 15:36:04,292 DEBUG    env_loc      Item env.location.sunrise = 2016-08-18 05:54:01.065441+02:00 via Logic None None -- item.py:__update:373
      2016-08-17 15:36:04,329 DEBUG    env_init     Item env.core.start = 2016-08-17 15:36:04.327675+02:00 via Logic None None -- item.py:__update:373
      2016-08-17 15:36:04,330 DEBUG    sh.gc        Garbage collector: collected 0 objects. -- smarthome.py:_garbage_collection:522
      2016-08-17 15:36:04,339 DEBUG    env_loc      Item env.location.sunset = 2016-08-17 20:27:13.076687+02:00 via Logic None None -- item.py:__update:373
      2016-08-17 15:36:04,343 DEBUG    env_init     Item env.system.name = raspberrypi via Logic None None -- item.py:__update:373
      2016-08-17 15:36:04,377 DEBUG    env_loc      Item env.location.moonrise = 2016-08-17 19:48:44.880586+02:00 via Logic None None -- item.py:__update:373
      2016-08-17 15:36:04,380 DEBUG    env_init     Item env.system.start = 2016-08-17 15:26:14.378624+02:00 via Logic None None -- item.py:__update:373
      2016-08-17 15:36:04,402 DEBUG    env_loc      Item env.location.moonset = 2016-08-18 05:49:37.113309+02:00 via Logic None None -- item.py:__update:373
      2016-08-17 15:36:04,413 DEBUG    env_loc      Item env.location.moonphase = 4 via Logic None None -- item.py:__update:373
      2016-08-17 15:36:04,423 DEBUG    sh.gc        Object references: 11409 -- smarthome.py:_maintenance:514
      2016-08-17 15:36:04,433 DEBUG    env_loc      Item env.location.day = True via Logic None None -- item.py:__update:373
      2016-08-17 15:36:04,783 DEBUG    Scheduler    sh.gc next time: 2016-08-18 02:04:00+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:36:04,802 DEBUG    Scheduler    env_loc next time: 2016-08-17 16:06:04+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:36:09,336 DEBUG    env_stat     Item env.core.threads = 7 via Logic None None -- item.py:__update:373
      2016-08-17 15:36:09,343 DEBUG    env_stat     Item env.core.memory = 12918784 via Logic None None -- item.py:__update:373
      2016-08-17 15:36:09,345 DEBUG    env_stat     Item env.system.load = 0.14 via Logic None None -- item.py:__update:373
      2016-08-17 15:36:09,347 DEBUG    env_stat     Item env.location.moonlight = 99 via Logic None None -- item.py:__update:373
      2016-08-17 15:36:09,743 DEBUG    Main         WebSocket: incoming connection from 192.168.178.38:56095 to 192.168.178.31:2424 -- connection.py:accept:187
      2016-08-17 15:36:09,746 DEBUG    Main         rfc6455 Handshake -- __init__.py:rfc6455_handshake:392
      2016-08-17 15:36:09,833 DEBUG    Scheduler    env_stat next time: 2016-08-17 15:41:09+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:36:10,019 DEBUG    Main         192.168.178.38:56095 sent '{"cmd":"proto","ver":3}' -- __init__.py:json_parse:273
      2016-08-17 15:36:10,028 DEBUG    Main         192.168.178.38:56095 sent '{"cmd":"monitor","items":["ventilation.outside_temp","ventilation.inside_temp","ventilation.exhaust_temp","ventilation.incoming_temp","ventilation.fanspeed","ventilation.booster.logics.boost_duration","ventilation.clean_filter","ventilation.power_state","ventilation.bypass_disabled","ventilation.fanspeed.uzsu_timer","ventilation.booster.built_in.on_switch","ventilation.booster.logics.switch","ventilation.boost_remaining_a","ventilation.error_handler.error_string.code","ventilation.error_handler.error_string.description","ventilation.error_handler.error_string.cause","ventilation.error_handler.error_string.solution","ventilation.min_fanspeed","ventilation.max_fanspeed","ventilation.bypass_temp","ventilation.device_error","ventilation.fan_in_on_off","ventilation.fan_in_percent","ventilation.fan_out_on_off","ventilation.fan_out_percent","ventilation.booster.built_in.mode","ventilation.airflow","ventilation.air_exchange_rate","ventilation.energy_loss","ventilation.energy_saving","ventilation.efficiency","ventilation.consumption_ventilators","ventilation.booster.logics.fireplace_duration","ventilation.booster.logics.level"]}' -- __init__.py:json_parse:273
      2016-08-17 15:36:10,112 DEBUG    Main         192.168.178.38:56095 sent '{"cmd":"item","id":"ventilation.booster.logics.boost_duration","val":2700}' -- __init__.py:json_parse:273
      2016-08-17 15:36:10,163 DEBUG    Main         192.168.178.38:56095 sent '{"cmd":"item","id":"ventilation.booster.logics.boost_duration","val":2700}' -- __init__.py:json_parse:273
      2016-08-17 15:36:10,221 DEBUG    Main         192.168.178.38:56095 sent '{"cmd":"item","id":"ventilation.booster.logics.fireplace_duration","val":0}' -- __init__.py:json_parse:273
      2016-08-17 15:36:10,230 DEBUG    Main         192.168.178.38:56095 sent '{"cmd":"item","id":"ventilation.booster.logics.fireplace_duration","val":0}' -- __init__.py:json_parse:273
      2016-08-17 15:36:14,345 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:36:14,351 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:36:14,437 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:14,454 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:14,455 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:36:14,457 DEBUG    Helios       Item ventilation.fan_in_percent = 100 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:14,459 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:36:14,530 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:14,548 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:14,549 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:36:14,550 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:36:14,621 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:14,638 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:14,639 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:36:14,641 DEBUG    Helios       Item ventilation.bypass_temp = 5 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:14,643 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:36:14,714 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:14,732 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:14,733 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:36:14,734 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:36:14,805 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:14,822 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:14,823 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:36:14,825 DEBUG    Helios       Item ventilation.booster.built_in.mode = 1 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:14,827 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:36:14,847 DEBUG    Scheduler    Helios next time: 2016-08-17 15:37:14+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:36:14,898 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:14,915 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:14,916 DEBUG    Helios       Value for boost_status (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:36:14,917 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:36:14,988 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:15,005 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:15,006 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:36:15,007 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:36:15,078 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:15,095 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:15,096 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:36:15,097 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:36:15,168 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:15,186 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x32 0x95 0x08' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:15,186 DEBUG    Helios       Value for outside_temp (0x32) received: 0x95|10010101|149 --> converted = 16 -- __init__.py:readValue:399
      2016-08-17 15:36:15,188 DEBUG    Helios       Item ventilation.outside_temp = 16 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:15,190 DEBUG    Helios       Triggering ventilation.energy_saving - by: Helios source: None dest: None value: {'value': 16, 'source': 'ventilation.out -- scheduler.py:trigger:164
      2016-08-17 15:36:15,191 DEBUG    Helios       Triggering ventilation.efficiency - by: Helios source: None dest: None value: {'value': 16, 'source': 'ventilation.out -- scheduler.py:trigger:164
      2016-08-17 15:36:15,193 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:36:15,195 DEBUG    ventilation.efficiency Item ventilation.efficiency = -400 via Eval ventilation.outside_temp None -- item.py:__update:373
      2016-08-17 15:36:15,267 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:15,285 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:15,285 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:36:15,287 DEBUG    Helios       Item ventilation.max_fanspeed = 8 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:15,289 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:36:15,361 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:15,377 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:15,378 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:36:15,380 DEBUG    Helios       Item ventilation.fan_out_percent = 100 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:15,382 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:36:15,453 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:15,471 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:15,472 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:36:15,474 DEBUG    Helios       Item ventilation.inside_temp = 24 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:15,476 DEBUG    Helios       Triggering ventilation.energy_loss - by: Helios source: None dest: None value: {'value': 24, 'source': 'ventilation.ins -- scheduler.py:trigger:164
      2016-08-17 15:36:15,477 DEBUG    Helios       Triggering ventilation.efficiency - by: Helios source: None dest: None value: {'value': 24, 'source': 'ventilation.ins -- scheduler.py:trigger:164
      2016-08-17 15:36:15,479 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:36:15,481 DEBUG    ventilation.efficiency Item ventilation.efficiency = -200 via Eval ventilation.inside_temp None -- item.py:__update:373
      2016-08-17 15:36:15,554 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:15,571 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:15,572 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:36:15,574 DEBUG    Helios       Item ventilation.min_fanspeed = 4 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:15,576 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:36:15,647 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:15,664 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:15,665 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      2016-08-17 15:36:15,667 DEBUG    Helios       Item ventilation.incoming_temp = 17 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:15,669 DEBUG    Helios       Triggering ventilation.energy_loss - by: Helios source: None dest: None value: {'value': 17, 'source': 'ventilation.inc -- scheduler.py:trigger:164
      2016-08-17 15:36:15,669 DEBUG    Helios       Triggering ventilation.energy_saving - by: Helios source: None dest: None value: {'value': 17, 'source': 'ventilation.inc -- scheduler.py:trigger:164
      2016-08-17 15:36:15,671 DEBUG    Helios       Triggering ventilation.efficiency - by: Helios source: None dest: None value: {'value': 17, 'source': 'ventilation.inc -- scheduler.py:trigger:164
      2016-08-17 15:36:15,673 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:36:15,675 DEBUG    ventilation.efficiency Item ventilation.efficiency = 12 via Eval ventilation.incoming_temp None -- item.py:__update:373
      2016-08-17 15:36:15,749 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:15,765 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x1F 0x89' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:15,766 DEBUG    Helios       Value for fanspeed (0x29) received: 0x1F|00011111|31 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:36:15,768 DEBUG    Helios       Item ventilation.fanspeed = 5 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:15,770 DEBUG    Helios       Triggering ventilation.consumption_ventilators - by: Helios source: None dest: None value: {'value': 5, 'source': 'ventilation.fans -- scheduler.py:trigger:164
      2016-08-17 15:36:15,771 DEBUG    Helios       Triggering ventilation.airflow - by: Helios source: None dest: None value: {'value': 5, 'source': 'ventilation.fans -- scheduler.py:trigger:164
      2016-08-17 15:36:15,773 DEBUG    ventilation.consumption_ventilators Item ventilation.consumption_ventilators = 92 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:36:15,774 DEBUG    Helios       Triggering ventilation.air_exchange_rate - by: Helios source: None dest: None value: {'value': 5, 'source': 'ventilation.fans -- scheduler.py:trigger:164
      2016-08-17 15:36:15,776 DEBUG    ventilation.airflow Item ventilation.airflow = 270 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:36:15,779 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:36:15,781 DEBUG    ventilation.air_exchange_rate Item ventilation.air_exchange_rate = 0.49 via Eval ventilation.fanspeed None -- item.py:__update:373
      2016-08-17 15:36:15,784 DEBUG    ventilation.airflow Triggering ventilation.energy_loss - by: Eval source: ventilation.fanspeed dest: None value: {'value': 270, 'source': 'ventilation.ai -- scheduler.py:trigger:164
      2016-08-17 15:36:15,787 DEBUG    ventilation.airflow Triggering ventilation.energy_saving - by: Eval source: ventilation.fanspeed dest: None value: {'value': 270, 'source': 'ventilation.ai -- scheduler.py:trigger:164
      2016-08-17 15:36:15,789 DEBUG    ventilation.energy_loss Item ventilation.energy_loss = 540 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:36:15,794 DEBUG    ventilation.energy_saving Item ventilation.energy_saving = 77 via Eval ventilation.airflow None -- item.py:__update:373
      2016-08-17 15:36:15,855 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:15,872 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:15,873 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:36:15,874 DEBUG    Helios       Item ventilation.power_state = 1 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:15,876 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:36:15,948 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:15,965 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:15,965 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:36:15,967 DEBUG    Helios       Item ventilation.clean_filter = 4 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:15,969 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:36:16,040 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:16,057 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA9 0x1D' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:16,058 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA9|10101001|169 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:36:16,060 DEBUG    Helios       Item ventilation.exhaust_temp = 23 via Helios None None -- item.py:__update:373
      2016-08-17 15:36:16,062 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:36:16,133 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:36:16,151 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:36:16,152 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:37:14,045 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:37:14,046 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:37:14,181 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:14,198 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:14,199 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:37:14,199 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:37:14,271 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:14,288 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:14,289 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:37:14,290 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:37:14,361 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:14,378 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:14,379 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:37:14,380 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:37:14,451 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:14,468 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:14,469 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:37:14,470 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:37:14,541 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:14,548 DEBUG    Scheduler    Helios next time: 2016-08-17 15:38:14+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:37:14,559 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:14,559 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:37:14,560 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:37:14,632 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:14,649 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:14,649 DEBUG    Helios       Value for boost_status (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:37:14,650 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:37:14,722 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:14,739 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:14,740 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:37:14,740 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:37:14,812 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:14,829 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:14,830 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:37:14,831 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:37:14,902 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:14,919 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x32 0x95 0x08' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:14,920 DEBUG    Helios       Value for outside_temp (0x32) received: 0x95|10010101|149 --> converted = 16 -- __init__.py:readValue:399
      2016-08-17 15:37:14,921 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:37:14,992 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:15,009 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:15,010 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:37:15,011 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:37:15,083 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:15,100 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:15,100 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:37:15,101 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:37:15,173 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:15,190 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:15,191 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:37:15,191 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:37:15,263 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:15,280 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:15,281 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:37:15,282 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:37:15,354 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:15,370 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:15,371 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      2016-08-17 15:37:15,372 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:37:15,443 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:15,460 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x1F 0x89' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:15,461 DEBUG    Helios       Value for fanspeed (0x29) received: 0x1F|00011111|31 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:37:15,462 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:37:15,533 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:15,551 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:15,552 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:37:15,553 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:37:15,625 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:15,642 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:15,643 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:37:15,643 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:37:15,715 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:15,732 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA9 0x1D' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:15,733 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA9|10101001|169 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:37:15,734 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:37:15,805 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:37:15,822 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:37:15,823 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:37:20,245 DEBUG    Main         WebSocketHandler: closing socket 192.168.178.38:56095 -- connection.py:close:309
      2016-08-17 15:38:14,246 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:38:14,247 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:38:14,370 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:14,387 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:14,388 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:38:14,389 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:38:14,460 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:14,478 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:14,478 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:38:14,479 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:38:14,551 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:14,568 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:14,569 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:38:14,569 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:38:14,641 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:14,658 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:14,659 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:38:14,659 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:38:14,731 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:14,748 DEBUG    Scheduler    Helios next time: 2016-08-17 15:39:14+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:38:14,750 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:14,751 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:38:14,752 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:38:14,823 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:14,840 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:14,840 DEBUG    Helios       Value for boost_status (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:38:14,841 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:38:14,913 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:14,930 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:14,931 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:38:14,931 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:38:15,003 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:15,020 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:15,021 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:38:15,022 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:38:15,093 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:15,110 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x32 0x95 0x08' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:15,111 DEBUG    Helios       Value for outside_temp (0x32) received: 0x95|10010101|149 --> converted = 16 -- __init__.py:readValue:399
      2016-08-17 15:38:15,112 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:38:15,183 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:15,200 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:15,201 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:38:15,202 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:38:15,273 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:15,291 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:15,291 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:38:15,292 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:38:15,364 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:15,381 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:15,382 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:38:15,382 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:38:15,454 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:15,471 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:15,472 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:38:15,473 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:38:15,544 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:15,561 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:15,562 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      2016-08-17 15:38:15,563 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:38:15,634 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:15,651 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x1F 0x89' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:15,652 DEBUG    Helios       Value for fanspeed (0x29) received: 0x1F|00011111|31 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:38:15,653 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:38:15,724 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:15,741 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:15,742 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:38:15,743 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:38:15,814 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:15,832 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:15,832 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:38:15,833 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:38:15,904 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:15,922 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA9 0x1D' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:15,923 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA9|10101001|169 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:38:15,923 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:38:16,131 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:38:16,148 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:38:16,148 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:39:14,444 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:39:14,445 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:39:14,567 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:14,583 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:14,584 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:39:14,584 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:39:14,655 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:14,671 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:14,671 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:39:14,672 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:39:14,743 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:14,759 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:14,759 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:39:14,759 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:39:14,830 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:14,846 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:14,847 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:39:14,847 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:39:14,918 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:14,934 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:14,934 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:39:14,935 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:39:14,962 DEBUG    Scheduler    Helios next time: 2016-08-17 15:40:14+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:39:15,006 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:15,022 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:15,022 DEBUG    Helios       Value for boost_status (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:39:15,023 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:39:15,093 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:15,109 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:15,110 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:39:15,110 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:39:15,181 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:15,197 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:15,198 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:39:15,198 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:39:15,269 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:15,285 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x32 0x95 0x08' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:15,285 DEBUG    Helios       Value for outside_temp (0x32) received: 0x95|10010101|149 --> converted = 16 -- __init__.py:readValue:399
      2016-08-17 15:39:15,286 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:39:15,356 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:15,372 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:15,373 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:39:15,373 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:39:15,444 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:15,461 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:15,462 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:39:15,462 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:39:15,533 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:15,549 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:15,549 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:39:15,550 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:39:15,621 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:15,637 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:15,637 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:39:15,638 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:39:15,708 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:15,724 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:15,725 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      2016-08-17 15:39:15,725 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:39:15,796 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:15,812 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x1F 0x89' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:15,813 DEBUG    Helios       Value for fanspeed (0x29) received: 0x1F|00011111|31 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:39:15,813 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:39:15,884 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:15,900 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:15,900 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:39:15,901 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:39:15,972 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:15,987 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:15,988 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:39:15,988 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:39:16,059 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:16,075 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA9 0x1D' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:16,076 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA9|10101001|169 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:39:16,076 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:39:16,147 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:39:16,163 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:39:16,163 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:40:09,897 DEBUG    Main         WebSocket: incoming connection from 192.168.178.40:54421 to 192.168.178.31:2424 -- connection.py:accept:187
      2016-08-17 15:40:10,061 DEBUG    Main         rfc6455 Handshake -- __init__.py:rfc6455_handshake:392
      2016-08-17 15:40:10,081 DEBUG    Main         192.168.178.40:54421 sent '{"cmd":"proto","ver":3}' -- __init__.py:json_parse:273
      2016-08-17 15:40:10,085 DEBUG    Main         192.168.178.40:54421 sent '{"cmd":"monitor","items":["ventilation.outside_temp","ventilation.inside_temp","ventilation.exhaust_temp","ventilation.incoming_temp","ventilation.fanspeed","ventilation.booster.logics.boost_duration","ventilation.clean_filter","ventilation.power_state","ventilation.bypass_disabled","ventilation.fanspeed.uzsu_timer","ventilation.booster.built_in.on_switch","ventilation.booster.logics.switch","ventilation.boost_remaining_a","ventilation.error_handler.error_string.code","ventilation.error_handler.error_string.description","ventilation.error_handler.error_string.cause","ventilation.error_handler.error_string.solution","ventilation.min_fanspeed","ventilation.max_fanspeed","ventilation.bypass_temp","ventilation.device_error","ventilation.fan_in_on_off","ventilation.fan_in_percent","ventilation.fan_out_on_off","ventilation.fan_out_percent","ventilation.booster.built_in.mode","ventilation.airflow","ventilation.air_exchange_rate","ventilation.energy_loss","ventilation.energy_saving","ventilation.efficiency","ventilation.consumption_ventilators","ventilation.booster.logics.fireplace_duration","ventilation.booster.logics.level"]}' -- __init__.py:json_parse:273
      2016-08-17 15:40:10,227 DEBUG    Main         192.168.178.40:54421 sent '{"cmd":"item","id":"ventilation.booster.logics.boost_duration","val":2700}' -- __init__.py:json_parse:273
      2016-08-17 15:40:10,234 DEBUG    Main         192.168.178.40:54421 sent '{"cmd":"item","id":"ventilation.booster.logics.boost_duration","val":2700}' -- __init__.py:json_parse:273
      2016-08-17 15:40:10,405 DEBUG    Main         192.168.178.40:54421 sent '{"cmd":"item","id":"ventilation.booster.logics.fireplace_duration","val":0}' -- __init__.py:json_parse:273
      2016-08-17 15:40:10,407 DEBUG    Main         192.168.178.40:54421 sent '{"cmd":"item","id":"ventilation.booster.logics.fireplace_duration","val":0}' -- __init__.py:json_parse:273
      2016-08-17 15:40:14,149 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:40:14,150 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:40:14,273 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:14,289 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:14,290 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:40:14,291 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:40:14,362 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:14,379 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:14,380 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:40:14,381 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:40:14,453 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:14,470 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:14,470 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:40:14,471 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:40:14,543 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:14,560 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:14,561 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:40:14,561 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:40:14,633 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:14,650 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:14,651 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:40:14,652 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:40:14,663 DEBUG    Scheduler    Helios next time: 2016-08-17 15:41:14+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:40:14,723 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:16,144 ERROR    Helios       Helios: No valid value for 'boost_status' from ventilation system received. -- __init__.py:readValue:403
      2016-08-17 15:40:16,146 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:40:16,218 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:16,234 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:16,235 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:40:16,236 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:40:16,307 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:16,325 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:16,325 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:40:16,326 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:40:16,397 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:16,415 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x32 0x95 0x08' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:16,416 DEBUG    Helios       Value for outside_temp (0x32) received: 0x95|10010101|149 --> converted = 16 -- __init__.py:readValue:399
      2016-08-17 15:40:16,417 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:40:16,488 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:16,505 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:16,506 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:40:16,506 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:40:16,578 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:16,595 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:16,596 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:40:16,597 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:40:16,668 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:16,685 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:16,686 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:40:16,687 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:40:16,758 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:16,775 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:16,776 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:40:16,777 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:40:16,848 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:16,866 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:16,867 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      2016-08-17 15:40:16,867 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:40:16,939 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:16,956 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x1F 0x89' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:16,957 DEBUG    Helios       Value for fanspeed (0x29) received: 0x1F|00011111|31 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:40:16,957 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:40:17,029 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:17,046 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:17,047 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:40:17,048 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:40:17,119 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:17,136 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:17,137 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:40:17,138 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:40:17,210 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:17,228 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA9 0x1D' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:17,229 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA9|10101001|169 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:40:17,230 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:40:17,301 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:40:17,318 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:40:17,319 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:41:09,381 DEBUG    env_stat     Item env.system.load = 0.05 via Logic None None -- item.py:__update:373
      2016-08-17 15:41:09,864 DEBUG    Scheduler    env_stat next time: 2016-08-17 15:46:09+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:41:14,380 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:41:14,381 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:41:14,503 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:14,521 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:14,522 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:41:14,522 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:41:14,594 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:14,611 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:14,612 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:41:14,613 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:41:14,684 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:14,701 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:14,702 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:41:14,703 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:41:14,774 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:14,791 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:14,792 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:41:14,793 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:41:14,864 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:14,881 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:14,882 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:41:14,883 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:41:14,893 DEBUG    Scheduler    Helios next time: 2016-08-17 15:42:14+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:41:14,954 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:14,972 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:14,972 DEBUG    Helios       Value for boost_status (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:41:14,973 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:41:15,045 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:15,062 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:15,063 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:41:15,063 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:41:15,135 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:15,152 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:15,153 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:41:15,154 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:41:15,225 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:15,242 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x32 0x95 0x08' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:15,243 DEBUG    Helios       Value for outside_temp (0x32) received: 0x95|10010101|149 --> converted = 16 -- __init__.py:readValue:399
      2016-08-17 15:41:15,244 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:41:15,315 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:15,332 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:15,333 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:41:15,334 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:41:15,405 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:15,423 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:15,423 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:41:15,424 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:41:15,496 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:15,513 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:15,514 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:41:15,514 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:41:15,586 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:15,603 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:15,604 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:41:15,605 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:41:15,676 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:15,693 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:15,694 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      2016-08-17 15:41:15,695 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:41:15,766 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:15,783 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x1F 0x89' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:15,784 DEBUG    Helios       Value for fanspeed (0x29) received: 0x1F|00011111|31 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:41:15,785 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:41:15,856 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:15,873 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:15,874 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:41:15,875 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:41:15,946 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:15,964 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:15,964 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:41:15,965 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:41:16,037 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:16,054 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA9 0x1D' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:16,055 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA9|10101001|169 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:41:16,055 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:41:16,127 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:41:16,144 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:41:16,145 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:42:14,092 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:42:14,093 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:42:14,220 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:14,237 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:14,238 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:42:14,239 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:42:14,310 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:14,327 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:14,328 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:42:14,329 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:42:14,400 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:14,417 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:14,418 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:42:14,419 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:42:14,490 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:14,507 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:14,508 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:42:14,509 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:42:14,581 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:14,595 DEBUG    Scheduler    Helios next time: 2016-08-17 15:43:14+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:42:14,598 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:14,599 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:42:14,599 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:42:14,671 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:14,688 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:14,689 DEBUG    Helios       Value for boost_status (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:42:14,689 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:42:14,761 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:14,778 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:14,779 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:42:14,780 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:42:14,851 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:14,868 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:14,869 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:42:14,870 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:42:14,941 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:14,958 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x32 0x95 0x08' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:14,959 DEBUG    Helios       Value for outside_temp (0x32) received: 0x95|10010101|149 --> converted = 16 -- __init__.py:readValue:399
      2016-08-17 15:42:14,960 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:42:15,031 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:15,049 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:15,049 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:42:15,050 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:42:15,122 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:15,139 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:15,140 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:42:15,140 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:42:15,212 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:15,229 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:15,230 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:42:15,231 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:42:15,302 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:15,319 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:15,320 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:42:15,321 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:42:15,392 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:15,409 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:15,410 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      2016-08-17 15:42:15,411 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:42:15,482 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:15,499 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x1F 0x89' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:15,500 DEBUG    Helios       Value for fanspeed (0x29) received: 0x1F|00011111|31 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:42:15,501 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:42:15,573 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:15,590 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:15,591 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:42:15,592 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:42:15,663 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:15,681 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:15,682 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:42:15,683 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:42:15,754 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:15,771 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA9 0x1D' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:15,772 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA9|10101001|169 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:42:15,773 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:42:15,844 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:42:15,861 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:42:15,862 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:42:57,527 DEBUG    Main         WebSocketHandler: closing socket 192.168.178.40:54421 -- connection.py:close:309
      2016-08-17 15:43:14,295 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:43:14,296 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:43:14,418 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:14,435 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:14,436 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:43:14,437 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:43:14,508 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:14,525 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:14,526 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:43:14,527 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:43:14,598 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:14,616 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:14,616 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:43:14,617 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:43:14,689 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:14,706 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:14,707 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:43:14,707 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:43:14,779 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:14,796 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:14,797 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:43:14,798 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:43:14,813 DEBUG    Scheduler    Helios next time: 2016-08-17 15:44:14+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:43:14,869 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:14,886 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:14,887 DEBUG    Helios       Value for boost_status (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:43:14,888 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:43:14,959 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:14,976 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:14,977 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:43:14,978 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:43:15,049 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:15,067 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:15,067 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:43:15,068 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:43:15,139 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:15,157 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x32 0x95 0x08' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:15,157 DEBUG    Helios       Value for outside_temp (0x32) received: 0x95|10010101|149 --> converted = 16 -- __init__.py:readValue:399
      2016-08-17 15:43:15,158 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:43:15,230 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:15,247 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:15,248 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:43:15,249 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:43:15,320 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:15,337 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:15,338 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:43:15,339 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:43:15,543 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:15,561 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:15,561 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:43:15,562 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:43:15,634 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:15,651 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:15,652 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:43:15,652 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:43:15,724 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:15,741 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:15,742 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      2016-08-17 15:43:15,743 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:43:15,814 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:15,831 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x1F 0x89' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:15,832 DEBUG    Helios       Value for fanspeed (0x29) received: 0x1F|00011111|31 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:43:15,833 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:43:15,904 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:15,921 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:15,922 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:43:15,923 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:43:15,994 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:16,011 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:16,012 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:43:16,013 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:43:16,084 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:16,102 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA9 0x1D' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:16,102 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA9|10101001|169 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:43:16,103 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:43:16,174 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:43:16,192 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:43:16,193 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:44:14,007 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:44:14,008 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:44:14,130 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:14,148 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:14,149 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:44:14,149 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:44:14,226 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:14,243 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:14,244 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:44:14,245 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:44:14,316 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:14,333 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:14,334 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:44:14,335 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:44:14,406 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:14,423 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x36 0x00 0x77' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:14,424 DEBUG    Helios       Value for device_error (0x36) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:44:14,425 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:44:14,496 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAA 0xEB' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:14,513 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAA 0x3A 0x25' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:14,514 DEBUG    Helios       Value for boost_mode (0xAA) received: 0x3A|00111010|58 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:44:14,515 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:44:14,523 DEBUG    Scheduler    Helios next time: 2016-08-17 15:45:14+02:00 -- scheduler.py:_next_time:303
      2016-08-17 15:44:14,586 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:14,604 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:14,604 DEBUG    Helios       Value for boost_status (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:44:14,605 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:44:14,677 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x08 0x49' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:14,694 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x08 0x03 0x4C' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:14,695 DEBUG    Helios       Value for fan_in_on_off (0x08) received: 0x03|00000011|3 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:44:14,695 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:44:14,767 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:14,784 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:14,785 DEBUG    Helios       Value for bypass_disabled (0xA3) received: 0x01|00000001|1 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:44:14,786 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:44:14,857 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x32 0x73' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:14,874 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x32 0x95 0x08' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:14,875 DEBUG    Helios       Value for outside_temp (0x32) received: 0x95|10010101|149 --> converted = 16 -- __init__.py:readValue:399
      2016-08-17 15:44:14,876 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:44:14,947 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA5 0xE6' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:14,964 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA5 0xFF 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:14,965 DEBUG    Helios       Value for max_fanspeed (0xA5) received: 0xFF|11111111|255 --> converted = 8 -- __init__.py:readValue:399
      2016-08-17 15:44:14,966 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:44:15,037 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB1 0xF2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:15,055 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB1 0x64 0x56' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:15,055 DEBUG    Helios       Value for fan_out_percent (0xB1) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:44:15,056 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:44:15,127 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x34 0x75' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:15,145 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x34 0xAA 0x1F' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:15,146 DEBUG    Helios       Value for inside_temp (0x34) received: 0xAA|10101010|170 --> converted = 24 -- __init__.py:readValue:399
      2016-08-17 15:44:15,146 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:44:15,218 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA9 0xEA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:15,235 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA9 0x0F 0xF9' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:15,236 DEBUG    Helios       Value for min_fanspeed (0xA9) received: 0x0F|00001111|15 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:44:15,236 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:44:15,308 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x35 0x76' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:15,325 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x35 0x99 0x0F' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:15,326 DEBUG    Helios       Value for incoming_temp (0x35) received: 0x99|10011001|153 --> converted = 17 -- __init__.py:readValue:399
      2016-08-17 15:44:15,327 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:44:15,398 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x29 0x6A' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:15,415 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x29 0x1F 0x89' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:15,416 DEBUG    Helios       Value for fanspeed (0x29) received: 0x1F|00011111|31 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:44:15,417 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:44:15,488 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xA3 0xE4' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:15,505 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xA3 0x01 0xE5' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:15,506 DEBUG    Helios       Value for power_state (0xA3) received: 0x01|00000001|1 --> converted = 1 -- __init__.py:readValue:399
      2016-08-17 15:44:15,507 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:44:15,579 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAB 0xEC' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:15,596 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAB 0x04 0xF0' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:15,596 DEBUG    Helios       Value for clean_filter (0xAB) received: 0x04|00000100|4 --> converted = 4 -- __init__.py:readValue:399
      2016-08-17 15:44:15,597 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:44:15,669 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x33 0x74' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:15,686 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x33 0xA9 0x1D' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:15,687 DEBUG    Helios       Value for exhaust_temp (0x33) received: 0xA9|10101001|169 --> converted = 23 -- __init__.py:readValue:399
      2016-08-17 15:44:15,687 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:44:15,759 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x79 0xBA' -- __init__.py:_sendTelegram:152
      2016-08-17 15:44:15,776 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x79 0x00 0xBA' -- __init__.py:_readTelegram:175
      2016-08-17 15:44:15,777 DEBUG    Helios       Value for boost_remaining (0x79) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:45:14,222 DEBUG    Helios       Helios: Updating values -- __init__.py:_update:447
      2016-08-17 15:45:14,223 DEBUG    Helios       Helios: Reading value: fan_in_percent -- __init__.py:readValue:378
      2016-08-17 15:45:14,349 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xB0 0xF1' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:14,366 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xB0 0x64 0x55' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:14,367 DEBUG    Helios       Value for fan_in_percent (0xB0) received: 0x64|01100100|100 --> converted = 100 -- __init__.py:readValue:399
      2016-08-17 15:45:14,367 DEBUG    Helios       Helios: Reading value: boost_on -- __init__.py:readValue:378
      2016-08-17 15:45:14,438 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x71 0xB2' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:14,455 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0x71 0x00 0xB2' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:14,455 DEBUG    Helios       Value for boost_on (0x71) received: 0x00|00000000|0 --> converted = 0 -- __init__.py:readValue:399
      2016-08-17 15:45:14,456 DEBUG    Helios       Helios: Reading value: bypass_temp -- __init__.py:readValue:378
      2016-08-17 15:45:14,527 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0xAF 0xF0' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:14,544 DEBUG    Helios       Telegram received '0x01 0x11 0x2F 0xAF 0x73 0x63' -- __init__.py:_readTelegram:175
      2016-08-17 15:45:14,544 DEBUG    Helios       Value for bypass_temp (0xAF) received: 0x73|01110011|115 --> converted = 5 -- __init__.py:readValue:399
      2016-08-17 15:45:14,545 DEBUG    Helios       Helios: Reading value: device_error -- __init__.py:readValue:378
      2016-08-17 15:45:14,675 INFO     Main         Number of Threads: 7 -- smarthome.py:stop:367
      2016-08-17 15:45:14,675 INFO     Main         Stop Plugins -- plugin.py:stop:71
      2016-08-17 15:45:14,676 DEBUG    Helios       Helios: Sending telegram '0x01 0x2F 0x11 0x00 0x36 0x77' -- __init__.py:_sendTelegram:152
      2016-08-17 15:45:14,676 DEBUG    Main         Stopping helios Plugin -- plugin.py:stop:73
      2016-08-17 15:45:14,677 DEBUG    Main         HeliosBase: Disconnecting... -- __init__.py:disconnect:118
      2016-08-17 15:45:14,677 DEBUG    Main         Stopping uzsu Plugin -- plugin.py:stop:73
      2016-08-17 15:45:14,677 DEBUG    Main         Stopping ical Plugin -- plugin.py:stop:73
      2016-08-17 15:45:14,678 DEBUG    Main         Stopping visu Plugin -- plugin.py:stop:73
      2016-08-17 15:45:15,678 ERROR    Helios       Helios: No valid value for 'device_error' from ventilation system received. -- __init__.py:readValue:403
      2016-08-17 15:45:15,680 DEBUG    Helios       Helios: Reading value: boost_mode -- __init__.py:readValue:378
      2016-08-17 15:45:15,680 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,681 DEBUG    Helios       Helios: Reading value: boost_status -- __init__.py:readValue:378
      2016-08-17 15:45:15,681 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,682 DEBUG    Helios       Helios: Reading value: fan_in_on_off -- __init__.py:readValue:378
      2016-08-17 15:45:15,682 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,683 DEBUG    Helios       Helios: Reading value: bypass_disabled -- __init__.py:readValue:378
      2016-08-17 15:45:15,683 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,684 DEBUG    Helios       Helios: Reading value: outside_temp -- __init__.py:readValue:378
      2016-08-17 15:45:15,685 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,685 DEBUG    Helios       Helios: Reading value: max_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:45:15,686 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,687 DEBUG    Helios       Helios: Reading value: fan_out_percent -- __init__.py:readValue:378
      2016-08-17 15:45:15,687 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,688 DEBUG    Helios       Helios: Reading value: inside_temp -- __init__.py:readValue:378
      2016-08-17 15:45:15,688 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,689 DEBUG    Helios       Helios: Reading value: min_fanspeed -- __init__.py:readValue:378
      2016-08-17 15:45:15,689 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,690 DEBUG    Helios       Helios: Reading value: incoming_temp -- __init__.py:readValue:378
      2016-08-17 15:45:15,690 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,691 DEBUG    Helios       Helios: Reading value: fanspeed -- __init__.py:readValue:378
      2016-08-17 15:45:15,692 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,692 DEBUG    Helios       Helios: Reading value: power_state -- __init__.py:readValue:378
      2016-08-17 15:45:15,693 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,694 DEBUG    Helios       Helios: Reading value: clean_filter -- __init__.py:readValue:378
      2016-08-17 15:45:15,694 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,695 DEBUG    Helios       Helios: Reading value: exhaust_temp -- __init__.py:readValue:378
      2016-08-17 15:45:15,695 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,696 DEBUG    Helios       Helios: Reading value: boost_remaining -- __init__.py:readValue:378
      2016-08-17 15:45:15,696 ERROR    Helios       Helios: Exception in readValue() occurred: Attempting to use a port that is not open -- __init__.py:readValue:408
      2016-08-17 15:45:15,697 INFO     Main         SmartHome.py stopped -- smarthome.py:stop:391
      Init SmartHome.py 1.1.1
      Zuletzt geändert von MotteX; 18.08.2016, 21:35.

      Kommentar


        #33
        Ich habe gestern auch eine komplette Neuinstallation versucht gemäß Komplettanleitung. Bei mir kam auch ständig das rote Dreieck. Es lag daran, dass SmartHomeNG gar nicht gestartet ist wegen diverser Fehler in der Datei plugin.conf. Nach langem Rumprobieren habe ich's dann doch hinbekommen, siehe hier. Ich weiß nicht, was bei Dir das Problem ist, aber vielleicht hängt es tatsächlich mit dem User "smarthome" zusammen. Um den anzulegen habe ich mich an diese Anleitung gehalten.

        Uli

        Kommentar


          #34
          Ja, könnte es defintiv. Auch wenn es wieder den Zorn der Unix-Götter erregen könnte: Ich arbeite auf dem Pi nur als root. Passwortvergabe steht in der Anleitung, die ich Dir neulich verlinkt habe.
          /tom

          Kommentar


            #35
            So nach ein paar Tage testen, kann ich sagen das es mittlerweile läuft, wenn auch nicht perfekt.
            Allerdings muss ich nach dem Booten den Service Smarthome und Smarthome.py stoppen und Smarthome.py einzeln nochmals aufrufen. Keine Ahnung warum das so ist, ich findet keine Lösung dafür.
            Auch ein erneutes aufsetzen mit der neuen Anleitung und Smarthome 1.2 von gestern bringt hier keine Abhilfe.

            Kommentar


              #36
              Ich habe jetzt keine Idee, warum Du "nach dem Booten den Service Smarthome und Smarthome.py stoppen und Smarthome.py einzeln nochmals aufrufen" mußt. Warum mußt Du das? Läuft es sonst nicht? Läuft es dann zweimal? Ist ein wenig wie wahrsagen...

              Was meldet denn direkt nach dem Neustart (ohne stoppen & Co.) ein sudo ps ax | grep smart und ein sudo systemctl status smarthome.service ?

              Kommentar


                #37
                Hallo bmx,

                die Befehle liefern folgendes Ergebnis:

                Code:
                pi@raspberrypi:~ $ sudo ps ax | grep smart
                  750 ?        Sl     0:03 /usr/bin/python3 /usr/local/smarthome/bin/smarthome.py
                 1195 pts/1    S+     0:00 grep --color=auto smart
                Code:
                pi@raspberrypi:~ $ sudo systemctl status smarthome.service
                ● smarthome.service - SmartHomeNG daemon
                   Loaded: loaded (/lib/systemd/system/smarthome.service; enabled)
                   Active: active (running) since Di 2016-08-23 06:32:39 CEST; 13min ago
                  Process: 572 ExecStart=/usr/bin/python3 /usr/local/smarthome/bin/smarthome.py (code=exited, status=0/SUCCESS)
                 Main PID: 750 (python3)
                   CGroup: /system.slice/smarthome.service
                           └─750 /usr/bin/python3 /usr/local/smarthome/bin/smarthome.py
                
                Aug 23 06:32:34 raspberrypi systemd[1]: Starting SmartHomeNG daemon...
                Aug 23 06:32:39 raspberrypi python3[572]: Daemon PID 750
                Aug 23 06:32:39 raspberrypi systemd[1]: smarthome.service: Supervising process 750 which is not our child. We'll most likely not no...t exits.Aug 23 06:32:39 raspberrypi systemd[1]: Started SmartHomeNG daemon.
                Hint: Some lines were ellipsized, use -l to show in full.
                Leider kann ich damit nicht viel anfangen...

                Kommentar


                  #38
                  Jedoch läuft das Plugin nicht hier kommt folgender Fehler:

                  Code:
                  [pi@raspberrypi:~ $ tail /usr/local/smarthome/var/log/smarthome.log
                  2016-08-23  06:47:56 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  06:47:56 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  06:47:56 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  06:47:56 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  06:47:56 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  06:47:56 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  06:48:09 INFO     Main         VISU: Websocket handler uses protocol version 3
                  2016-08-23  06:48:14 WARNING  Main         Client 192.168.178.40:50687 requested invalid series: env.system.load.
                  2016-08-23  06:48:14 WARNING  Main         Client 192.168.178.40:50687 requested invalid series: env.core.threads.
                  2016-08-23  06:48:14 WARNING  Main         Client 192.168.178.40:50687 requested invalid series: env.core.memory.
                  ein einfaches stoppen und Neustarten von smarthome.py geht auch nicht dann kommt es zu diesem Fehler:

                  Code:
                  pi@raspberrypi:~ $ cd /usr/local/smarthome/bin
                  pi@raspberrypi:/usr/local/smarthome/bin $ ./smarthome.py -s
                  pi@raspberrypi:/usr/local/smarthome/bin $ ./smarthome.py -v
                  Daemon PID 1241
                  pi@raspberrypi:/usr/local/smarthome/bin $ tail /usr/local/smarthome/var/log/smarthome.log
                  2016-08-23  06:51:57 INFO     smartvisu    install_widgets: Creating  directory for widgets
                  2016-08-23  06:51:57 INFO     smartvisu    install_widgets: Removing old dynamic widget files
                  2016-08-23  06:51:57 INFO     smartvisu    Adding import statements to root.html
                  2016-08-23  06:51:57 WARNING  smartvisu    Generating pages for smartVISU
                  2016-08-23  06:51:57 INFO     smartvisu    copy_templates: Copying template 'roomlite.html' from plugin to smartVISU
                  2016-08-23  06:51:58 WARNING  ventilation.error_handler.error_string.code Item ventilation.error_handler.error_string.code: problem evaluating self.parent.parent(): 'Item' object has no attribute 'parent'
                  2016-08-23  06:51:58 WARNING  ventilation.error_handler.error_string.cause Item ventilation.error_handler.error_string.cause: problem evaluating self.parent().split(':')[1]: 'Item' object has no attribute 'parent'
                  2016-08-23  06:51:59 WARNING  ventilation.error_handler.error_string.solution Item ventilation.error_handler.error_string.solution: problem evaluating self.parent().split(':')[2]: 'Item' object has no attribute 'parent'
                  2016-08-23  06:51:59 WARNING  ventilation.error_handler.error_string Item ventilation.error_handler.error_string: problem evaluating ("self.return_parent().conf['" + self.parent() + "']"): 'Item' object has no attribute 'parent'
                  2016-08-23  06:51:59 ERROR    Connections  _websocket: problem binding 0.0.0.0:2424 (TCP): [Errno 98] Die Adresse wird bereits verwendet
                  Nach einiger Zeit da. 1-2 Minuten kommt dann bei erneuter Abfrage:

                  Code:
                  pi@raspberrypi:/usr/local/smarthome/bin $ tail /usr/local/smarthome/var/log/smarthome.log
                  2016-08-23  07:02:23 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  07:02:23 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  07:02:23 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  07:02:23 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  07:02:23 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  07:02:23 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  07:02:23 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  07:02:23 ERROR    Helios       Helios: Exception in readValue() occurred: 'bool' object has no attribute 'timeout'
                  2016-08-23  07:02:32 ERROR    Connections  _websocket: problem binding 0.0.0.0:2424 (TCP): [Errno 98] Die Adresse wird bereits verwendet
                  2016-08-23  07:02:42 ERROR    Connections  _websocket: problem binding 0.0.0.0:2424 (TCP): [Errno 98] Die Adresse wird bereits verwendet
                  Stope ich den Service Smarthome
                  Code:
                  sudo systemctl stop smarthome.service
                  und führe danach Smarthome.py
                  Code:
                  ./smarthome.py -v
                  aus dann läuft das ganze bis zu einen neuen reboot.
                  Zuletzt geändert von MotteX; 23.08.2016, 06:12.

                  Kommentar


                    #39
                    Vorsicht:
                    Smarthome einmal als root gestartet und danach geht es nur noch als root, wegen der Zugriffsrechte auf die Log Dateien

                    Kommentar


                      #40
                      Moin Reinhold,

                      Zitat von MotteX Beitrag anzeigen
                      Code:
                      pi@raspberrypi:~ $ sudo ps ax | grep smart
                      750 ? Sl 0:03 /usr/bin/python3 /usr/local/smarthome/bin/smarthome.py
                      1195 pts/1 S+ 0:00 grep --color=auto smart
                      Code:
                      pi@raspberrypi:~ $ sudo systemctl status smarthome.service
                      ● smarthome.service - SmartHomeNG daemon
                      Loaded: loaded (/lib/systemd/system/smarthome.service; enabled)
                      Active: active (running) since Di 2016-08-23 06:32:39 CEST; 13min ago
                      Process: 572 ExecStart=/usr/bin/python3 /usr/local/smarthome/bin/smarthome.py (code=exited, status=0/SUCCESS)
                      Main PID: 750 (python3)
                      CGroup: /system.slice/smarthome.service
                      └─750 /usr/bin/python3 /usr/local/smarthome/bin/smarthome.py
                      /usr/bin/python3 /usr/local/smarthome/bin/smarthome.py zeigt, das SmartHomeNG bereits bei Dir läuft

                      Führe mal
                      Code:
                      sudo systemctl stop smarthome.service
                      
                      sudo systemctl disable smarthome.service
                      aus, dann wird das Smarthome beenden und weiterhin der automatische Start bei Systemstart ausgeschaltet. Jetzt kannst Du mit

                      Code:
                      cd /usr/local/smarthome/bin
                      python3 ./smarthome.py -s
                      das evtl. noch manuell gestartete SmartHomeNG stoppen. Mit

                      Code:
                      cd /usr/local/smarthome/bin
                      python3 ./smarthome.py -d
                      startest Du SmartHomeNG im Debug Modus neu. Wenn Du allerdings jetzt dich mit exit abmeldest, dann läuft das im Hintergrund weiter. Um wieder neu zu starten, mußt Du das also erst beenden.

                      Gruß,
                      Bernd

                      Kommentar

                      Lädt...
                      X