activate_scenario.sh
Wed Jan 24 16:53:41 CET 2024
scenario: welcomeLight
phoneName: 0

'night' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'thomas@miglinci.name'

scenario: 'Willkommen-Licht EIN-schalten' - 'welcomeLight' - 'welcomelight'

Licht Vorzimmer (/srv/www/viehai/shelly/log_scenarios/2024/01/24/_0.log)

vorher: 16:53:41.847

http://192.168.12.103/relay/0?turn=on
  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "overpower": false,
  "source": "input"

nachher: 16:53:41.900
Dauer: 52 msec phName: '0'


Küche Licht Naßzeile (/srv/www/viehai/shelly/log_scenarios/2024/01/24/_1.log)

vorher: 16:53:41.872

http://192.168.12.116/white/0?turn=on&brightness=25
  "ison": true,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 25,
  "transition": 0,
  "power": 12.72,
  "overpower": false

nachher: 16:53:41.903
Dauer: 31 msec phName: '0'


Küche Licht Naßzeile (/srv/www/viehai/shelly/log_scenarios/2024/01/24/_2.log)

vorher: 16:53:41.893

http://192.168.12.116/white/1?turn=on&brightness=25
  "ison": true,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 25,
  "transition": 0,
  "power": 12.72,
  "overpower": false

nachher: 16:53:41.929
Dauer: 35 msec phName: '0'


Küche Licht Herdzeile (/srv/www/viehai/shelly/log_scenarios/2024/01/24/_3.log)

vorher: 16:53:41.917

http://192.168.12.117/white/0?turn=on&brightness=25
  "ison": true,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 25,
  "transition": 0,
  "power": 7.13,
  "overpower": false

nachher: 16:53:41.956
Dauer: 40 msec phName: '0'


Küche Licht Herdzeile (/srv/www/viehai/shelly/log_scenarios/2024/01/24/_4.log)

vorher: 16:53:41.932

http://192.168.12.117/white/1?turn=on&brightness=25
  "ison": true,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 25,
  "transition": 0,
  "power": 7.13,
  "overpower": false

nachher: 16:53:41.984
Dauer: 51 msec phName: '0'


scenario: 'Willkommen-Licht EIN-schalten' - 'welcomeLight' - 'welcomelight'

urls : 5
vorher : 16:53:41.793
nachher: 16:53:41.990
Dauer : 198 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/24//scene_welcomeLight_20240124_165341.txt'


syslog

Jan 24 16:50:01 srv4hai CRON[17484]: (root) CMD (/etc/linetest/linetest.sh)
Jan 24 16:50:01 srv4hai CRON[17485]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Jan 24 16:50:01 srv4hai meter.sh: SHELLY meter.sh started
Jan 24 16:51:02 srv4hai CRON[17856]: (root) CMD (/etc/linetest/linetest.sh)
Jan 24 16:51:08 srv4hai meter.sh: SHELLY meter.sh ended
Jan 24 16:51:51 srv4hai postfix/smtpd[17918]: connect from unknown[193.222.96.92]
Jan 24 16:51:51 srv4hai postfix/smtpd[17918]: warning: unknown[193.222.96.92]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jan 24 16:51:51 srv4hai postfix/smtpd[17918]: disconnect from unknown[193.222.96.92] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 24 16:52:01 srv4hai CRON[17927]: (root) CMD (/etc/linetest/linetest.sh)
Jan 24 16:52:16 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan 24 16:52:17 srv4hai fetchmail[1651]: 36330 messages (36329 seen) for tmiglinci at mail.akis.at (-1267055768 octets).
Jan 24 16:52:17 srv4hai postfix/smtpd[17918]: connect from localhost[127.0.0.1]
Jan 24 16:52:17 srv4hai postfix/smtpd[17918]: F128D6011A: client=localhost[127.0.0.1]
Jan 24 16:52:18 srv4hai postfix/cleanup[17943]: F128D6011A: message-id=
Jan 24 16:52:18 srv4hai postfix/qmgr[28610]: F128D6011A: from=, size=37833, nrcpt=1 (queue active)
Jan 24 16:52:18 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:36330 of 36330 (37601 octets) not flushed
Jan 24 16:52:18 srv4hai postfix/smtpd[17918]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Jan 24 16:52:18 srv4hai postfix/local[17944]: F128D6011A: to=, relay=local, delay=0.11, delays=0.09/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 24 16:52:18 srv4hai postfix/qmgr[28610]: F128D6011A: removed
Jan 24 16:52:18 srv4hai fetchmail[1651]: 9797 messages (9797 seen) for srozum at mail.akis.at (1183389483 octets).
Jan 24 16:52:19 srv4hai fetchmail[1651]: 21264 messages (21264 seen) for mrozum at mail.akis.at (-689927243 octets).
Jan 24 16:52:19 srv4hai fetchmail[1651]: 45 messages (45 seen) for admin@bastelstube.wien at pop3.world4you.com (12035480 octets).
Jan 24 16:53:01 srv4hai CRON[17975]: (root) CMD (/etc/linetest/linetest.sh)
Jan 24 16:53:30 srv4hai activate_scenario.sh: SHELLY scenario: 'LOG_kommen(log_kommen)' TO BE EXECUTED, phone=''
Jan 24 16:53:30 srv4hai postfix/pickup[5856]: 1033560244: uid=33 from=
Jan 24 16:53:30 srv4hai postfix/cleanup[17943]: 1033560244: message-id=<20240124155330.1033560244@mail.viehai.at>
Jan 24 16:53:30 srv4hai postfix/qmgr[28610]: 1033560244: from=, size=3157, nrcpt=1 (queue active)
Jan 24 16:53:30 srv4hai activate_scenario.sh: SHELLY scenario: 'LOG_kommen(log_kommen)' took 9 msec, phone=''
Jan 24 16:53:30 srv4hai bt_scan.sh: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' found: 'Yes'
Jan 24 16:53:30 srv4hai bt_scan.sh: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Jan 24 16:53:30 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan 24 16:53:30 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'scanBT/no IP, false/no IP, false/no IP,' - anyPresent: 'true'
Jan 24 16:53:30 srv4hai check_presence.sh: SHELLY (0)-coming: activate_scenario.shtml: welcomeLight
Jan 24 16:53:30 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1706111610
Jan 24 16:53:30 srv4hai activate_scenario.sh: SHELLY scenario: 'welcomeLight(welcomelight)' TO BE EXECUTED, phone='phoneName:'0''
Jan 24 16:53:30 srv4hai postfix/pickup[5856]: EE9B660245: uid=33 from=
Jan 24 16:53:30 srv4hai postfix/cleanup[17943]: EE9B660245: message-id=<20240124155330.EE9B660245@mail.viehai.at>
Jan 24 16:53:30 srv4hai postfix/qmgr[28610]: EE9B660245: from=, size=4378, nrcpt=1 (queue active)
Jan 24 16:53:30 srv4hai activate_scenario.sh: SHELLY: 'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Jan 24 16:53:30 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/24/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'0'
Jan 24 16:53:31 srv4hai activate_scenario.sh: SHELLY: 'shelly-16'-'Küche Licht Naßzeile' --> '0?turn=on&brightness=25'
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/24/_1.log' - shellyUsage:'Küche Licht Naßzeile' - scUrl:'http://192.168.12.116/white/0?turn=on&brightness=25' - phName:'0'
Jan 24 16:53:31 srv4hai activate_scenario.sh: SHELLY: 'shelly-16'-'Küche Licht Naßzeile' --> '1?turn=on&brightness=25'
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/24/_2.log' - shellyUsage:'Küche Licht Naßzeile' - scUrl:'http://192.168.12.116/white/1?turn=on&brightness=25' - phName:'0'
Jan 24 16:53:31 srv4hai activate_scenario.sh: SHELLY: 'shelly-17'-'Küche Licht Herdzeile' --> '0?turn=on&brightness=25'
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/24/_3.log' - shellyUsage:'Küche Licht Herdzeile' - scUrl:'http://192.168.12.117/white/0?turn=on&brightness=25' - phName:'0'
Jan 24 16:53:31 srv4hai postfix/relay/smtp[18044]: 1033560244: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=0.98, delays=0.01/0.01/0.72/0.24, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as D2F9D800BB)
Jan 24 16:53:31 srv4hai postfix/qmgr[28610]: 1033560244: removed
Jan 24 16:53:31 srv4hai activate_scenario.sh: SHELLY: 'shelly-17'-'Küche Licht Herdzeile' --> '1?turn=on&brightness=25'
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/24/_4.log' - shellyUsage:'Küche Licht Herdzeile' - scUrl:'http://192.168.12.117/white/1?turn=on&brightness=25' - phName:'0'
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.103/status'
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.103","rssi":-50},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"16:53","unixtime":1706111611,"serial":1,"has_update":false,"mac":"E09806AA0824","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"relays":[{"ison":true,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"overpower":false,"source":"input"}],"meters":[{"power":0.00,"overpower":0.00,"is_valid":true,"timestamp":1706115211,"counters":[0.000, 0.000, 0.000],"total":746264}],"inputs":[{"input":0,"event":"S","event_cnt":676}],"temperature":31.27,"overtemperature":false,"tmp":{"tC":31.27,"tF":88.28, "is_valid":true},"temperature_status":"Normal","ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"update":{"status":"idle","has_update":false,"new_version":"20230913-113709/v1.14.0-gcb84623","old_version":"20230913-113709/v1.14.0-gcb84623","beta_version":"20231107-164450/v1.14.1-rc1-g0617c15"},"ram_total":42960,"ram_free
Jan 24 16:53:31 srv4hai activate_scenario.sh: SHELLY scenario: 'welcomeLight(welcomelight)' took 157 msec, phone='phoneName:'0''
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.116/status'
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.116/status'
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.116","rssi":-58},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"16:53","unixtime":1706111611,"serial":1,"has_update":false,"mac":"C45BBE4B848E","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"mode":"white","input":0,"total_power":0.00,"lights":[{"ison":true,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":25,"transition":0,"power":0.00,"overpower":false},{"ison":true,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":25,"transition":0,"power":0.00,"overpower":false},{"ison":false,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":50,"transition":0,"power":0.00,"overpower":false},{"ison":false,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"whit
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.116","rssi":-58},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"16:53","unixtime":1706111611,"serial":1,"has_update":false,"mac":"C45BBE4B848E","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"mode":"white","input":0,"total_power":0.00,"lights":[{"ison":true,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":25,"transition":0,"power":0.00,"overpower":false},{"ison":true,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":25,"transition":0,"power":0.00,"overpower":false},{"ison":false,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":50,"transition":0,"power":0.00,"overpower":false},{"ison":false,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"whit
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.117/status'
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.117","rssi":-74},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"16:53","unixtime":1706111611,"serial":1,"has_update":false,"mac":"E8DB84A891C9","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"mode":"white","input":0,"total_power":0.00,"lights":[{"ison":true,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":25,"transition":0,"power":0.00,"overpower":false},{"ison":true,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":25,"transition":0,"power":0.00,"overpower":false},{"ison":false,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":50,"transition":0,"power":0.00,"overpower":false},{"ison":false,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"whit
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.117/status'
Jan 24 16:53:31 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.117","rssi":-73},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"16:53","unixtime":1706111611,"serial":1,"has_update":false,"mac":"E8DB84A891C9","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"mode":"white","input":0,"total_power":0.00,"lights":[{"ison":true,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":25,"transition":0,"power":0.00,"overpower":false},{"ison":true,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":25,"transition":0,"power":0.00,"overpower":false},{"ison":false,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":50,"transition":0,"power":0.00,"overpower":false},{"ison":false,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"whit
Jan 24 16:53:31 srv4hai postfix/relay/smtp[18153]: EE9B660245: to=, relay=mx01.nic.name[209.131.159.47]:25, delay=0.87, delays=0.01/0.01/0.62/0.24, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as A3F25208FC)
Jan 24 16:53:31 srv4hai postfix/qmgr[28610]: EE9B660245: removed
Jan 24 16:53:33 srv4hai ping_SP.sh: SHELLY (0)- ping 192.168.12.61 0 not answered (1) @~1706111613 - 'ping_SP_0'
Jan 24 16:53:41 srv4hai dhcpd[5037]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan 24 16:53:41 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 24 16:53:41 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 24 16:53:41 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.61
Jan 24 16:53:41 srv4hai dhcpd[5037]: execute_statement argv[2] = fpThomas
Jan 24 16:53:41 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas'
Jan 24 16:53:41 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan 24 16:53:41 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 24 16:53:41 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#55123/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 24 16:53:41 srv4hai named[14530]: client @0x7fc328166000 192.168.12.252#34043/key rndc-key: signer "rndc-key" approved
Jan 24 16:53:41 srv4hai named[14530]: client @0x7fc328166000 192.168.12.252#34043/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jan 24 16:53:41 srv4hai named[14530]: client @0x7fc328166000 192.168.12.252#34043/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan 24 16:53:41 srv4hai named[14530]: client @0x7fc328166000 192.168.12.252#34043/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jan 24 16:53:41 srv4hai named[14530]: client @0x7fc328166000 192.168.12.252#34043/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jan 24 16:53:41 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan 24 16:53:41 srv4hai dhcpd[5037]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jan 24 16:53:41 srv4hai named[14530]: client @0x7fc30807f600 192.168.12.252#60473/key rndc-key: signer "rndc-key" approved
Jan 24 16:53:41 srv4hai named[14530]: client @0x7fc30807f600 192.168.12.252#60473/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jan 24 16:53:41 srv4hai named[14530]: client @0x7fc30807f600 192.168.12.252#60473/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
Jan 24 16:53:41 srv4hai dhcpd[5037]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jan 24 16:53:41 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'scanBT/no ping, false/no IP, false/no IP,' - anyPresent: 'true'
Jan 24 16:53:41 srv4hai check_presence.sh: SHELLY (0)-coming: activate_scenario.shtml: welcomeLight
Jan 24 16:53:41 srv4hai ping_SP.sh: SHELLY - running process-id(18309): '18080 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61#01218309 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61' - 'ping_SP_0' - exiting ==============

finished