activate_scenario.sh
Tue Jan 16 07:07:23 CET 2024
scenario: LOG_kommen
'night' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'thomas@miglinci.name'
scenario: 'LOG_EIN' - 'LOG_kommen' - 'log_kommen'
scenario: 'LOG_EIN' - 'LOG_kommen' - 'log_kommen'
urls : 0
vorher : 07:07:23.523
nachher: 07:07:23.533
Dauer : 11 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/16//scene_LOG_kommen_20240116_070723.txt'
syslog
Jan 16 07:04:00 srv4hai named[14530]: resolver priming query complete
Jan 16 07:04:01 srv4hai CRON[27407]: (root) CMD (/etc/linetest/linetest.sh)
Jan 16 07:04:01 srv4hai named[14530]: resolver priming query complete
Jan 16 07:04:03 srv4hai dhcpd[8095]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan 16 07:04:03 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan 16 07:04:09 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705385049 - 'ping_SP_0'
Jan 16 07:04:12 srv4hai named[14530]: resolver priming query complete
Jan 16 07:04:17 srv4hai named[14530]: resolver priming query complete
Jan 16 07:04:29 srv4hai named[14530]: resolver priming query complete
Jan 16 07:04:32 srv4hai named[14530]: resolver priming query complete
Jan 16 07:04:39 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705385079 - 'ping_SP_0'
Jan 16 07:04:48 srv4hai named[14530]: resolver priming query complete
Jan 16 07:05:01 srv4hai CRON[27440]: (root) CMD (/etc/linetest/linetest.sh)
Jan 16 07:05:01 srv4hai named[14530]: resolver priming query complete
Jan 16 07:05:07 srv4hai dhcpd[8095]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan 16 07:05:07 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan 16 07:05:09 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705385109 - 'ping_SP_0'
Jan 16 07:05:25 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27461, secured, session=
Jan 16 07:05:25 srv4hai dovecot: imap(miglincit)<27461>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 16 07:05:40 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705385140 - 'ping_SP_0'
Jan 16 07:05:46 srv4hai named[14530]: resolver priming query complete
Jan 16 07:06:01 srv4hai CRON[27477]: (root) CMD (/etc/linetest/linetest.sh)
Jan 16 07:06:01 srv4hai named[14530]: resolver priming query complete
Jan 16 07:06:07 srv4hai named[14530]: resolver priming query complete
Jan 16 07:06:10 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705385170 - 'ping_SP_0'
Jan 16 07:06:11 srv4hai dhcpd[8095]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan 16 07:06:11 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan 16 07:06:30 srv4hai activate_scenario.sh: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED
Jan 16 07:06:30 srv4hai postfix/pickup[15282]: 82D0A60244: uid=33 from=
Jan 16 07:06:30 srv4hai postfix/cleanup[27547]: 82D0A60244: message-id=<20240116060630.82D0A60244@mail.viehai.at>
Jan 16 07:06:30 srv4hai postfix/qmgr[28610]: 82D0A60244: from=, size=3585, nrcpt=1 (queue active)
Jan 16 07:06:30 srv4hai activate_scenario.sh: SHELLY: 'shelly-08'-'Thomas Büro Regallicht' --> '0?turn=toggle'
Jan 16 07:06:30 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/16/_0.log' - shellyUsage:'Thomas Büro Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'noHandy'
Jan 16 07:06:30 srv4hai postfix/local[27561]: 82D0A60244: to=, orig_to=, relay=local, delay=0.04, delays=0.02/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 16 07:06:30 srv4hai postfix/cleanup[27547]: 8A98460245: message-id=<20240116060630.8A98460245@mail.viehai.at>
Jan 16 07:06:30 srv4hai activate_scenario.sh: SHELLY: 'shelly-40'-'Thomas Büro Licht' --> '0?turn=toggle'
Jan 16 07:06:30 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/16/_1.log' - shellyUsage:'Thomas Büro Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'noHandy'
Jan 16 07:06:30 srv4hai postfix/bounce[27566]: 82D0A60244: sender non-delivery notification: 8A98460245
Jan 16 07:06:30 srv4hai postfix/qmgr[28610]: 8A98460245: from=<>, size=5464, nrcpt=1 (queue active)
Jan 16 07:06:30 srv4hai postfix/qmgr[28610]: 82D0A60244: removed
Jan 16 07:06:30 srv4hai postfix/local[27561]: 8A98460245: to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 16 07:06:30 srv4hai postfix/qmgr[28610]: 8A98460245: removed
Jan 16 07:06:30 srv4hai activate_scenario.sh: SHELLY scenario: 'buero_UM(buero_um)' took 88 msec
Jan 16 07:06:30 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.108/status'
Jan 16 07:06:30 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.108","rssi":-67},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"07:06","unixtime":1705385190,"serial":1,"has_update":false,"mac":"8CAAB56203DF","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"relays":[{"ison":true,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"source":"http"}],"meters":[{"power":0.00,"is_valid":true}],"inputs":[{"input":1,"event":"","event_cnt":0}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"update":{"status":"idle","has_update":false,"new_version":"20230913-112003/v1.14.0-gcb84623","old_version":"20230913-112003/v1.14.0-gcb84623","beta_version":"20231107-162940/v1.14.1-rc1-g0617c15"},"ram_total":51688,"ram_free":40368,"fs_size":233681,"fs_free":150600,"uptime":6453381}'
Jan 16 07:06:30 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.140/status'
Jan 16 07:06:30 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.140","rssi":-67},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"07:06","unixtime":1705385190,"serial":750,"has_update":false,"mac":"98CDAC307B4F","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"relays":[{"ison":true,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"source":"http"}],"meters":[{"power":0.00,"is_valid":false,"timestamp":1705388790,"counters":[0.000, 0.000, 0.000],"total":0}],"inputs":[{"input":0,"event":"S","event_cnt":304},{"input":0,"event":"","event_cnt":0}],"temperature":43.69,"overtemperature":false,"tmp":{"tC":43.69,"tF":110.65,"is_valid":true},"update":{"status":"idle","has_update":false,"new_version":"20230913-112054/v1.14.0-gcb84623","old_version":"20230913-112054/v1.14.0-gcb84623","beta_version":"20231107-163031/v1.14.1-rc1-g0617c15"},"ram_total":51912,"ram_free":36772,"fs_size":233681,"fs_free":162648,"uptime":6453327}'
Jan 16 07:06:30 srv4hai named[14530]: resolver priming query complete
Jan 16 07:06:40 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705385200 - 'ping_SP_0'
Jan 16 07:06:42 srv4hai dhcpd[8095]: DHCPDISCOVER from c0:49:ef:8a:c9:d8 via enp2s0
Jan 16 07:06:42 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Jan 16 07:06:42 srv4hai dhcpd[8095]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 16 07:06:42 srv4hai dhcpd[8095]: execute_statement argv[1] = 192.168.12.139
Jan 16 07:06:42 srv4hai dhcpd[8095]: execute_statement argv[2] = shelly-39
Jan 16 07:06:42 srv4hai dhcpd[8095]: DHCPREQUEST for 192.168.12.139 (192.168.12.252) from c0:49:ef:8a:c9:d8 via enp2s0
Jan 16 07:06:42 srv4hai dhcpd[8095]: DHCPACK on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Jan 16 07:06:42 srv4hai named[14530]: client @0x7fc31001d550 192.168.12.252#36219/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-39.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 16 07:06:42 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#36101/key rndc-key: signer "rndc-key" approved
Jan 16 07:06:42 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#36101/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' TXT
Jan 16 07:06:42 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#36101/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' TXT "314be662bb43914e78b269d3f3bc9f38c7"
Jan 16 07:06:42 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#36101/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' A
Jan 16 07:06:42 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#36101/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' A 192.168.12.139
Jan 16 07:06:42 srv4hai dhcpd[8095]: Added new forward map from shelly-39.viehai.at to 192.168.12.139
Jan 16 07:06:42 srv4hai named[14530]: client @0x7fc310083bf0 192.168.12.252#47153/key rndc-key: signer "rndc-key" approved
Jan 16 07:06:42 srv4hai named[14530]: client @0x7fc310083bf0 192.168.12.252#47153/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '139.12.168.192.in-addr.arpa' PTR
Jan 16 07:06:42 srv4hai named[14530]: client @0x7fc310083bf0 192.168.12.252#47153/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '139.12.168.192.in-addr.arpa' PTR shelly-39.viehai.at.
Jan 16 07:06:42 srv4hai dhcpd[8095]: Added reverse map from 139.12.168.192.in-addr.arpa. to shelly-39.viehai.at
Jan 16 07:06:42 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-39' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Jan 16 07:06:42 srv4hai named[14530]: resolver priming query complete
Jan 16 07:06:43 srv4hai named[14530]: resolver priming query complete
Jan 16 07:06:43 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Jan 16 07:06:43 srv4hai ht_shelly.sh: SHELLY - working dir '/srv/www/viehai/shelly/wetter/2024/01'
Jan 16 07:06:43 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: gen=2&temp=1.100000&hum=56.900000&id=C049EF8AC9D8&batt=100&volt=6.640000
Jan 16 07:06:43 srv4hai ht_shelly.sh: SHELLY id => macID: '8A:C9:D8'
Jan 16 07:06:43 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Jan 16 07:06:43 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Jan 16 07:06:43 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Jan 16 07:06:43 srv4hai conf_shelly.sh: SHELLY:'shelly-39' 'conf(0)' - 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}'
Jan 16 07:06:43 srv4hai conf_shelly.sh: SHELLY:'shelly-39' 'conf(0)' - 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}'
Jan 16 07:06:43 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-cmd: 'curl --connect-timeout 3 --silent -X -POST -d 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}' http://192.168.12.139/rpc | jq -r '.''
Jan 16 07:06:43 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Jan 16 07:06:43 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-cmd: 'curl --connect-timeout 3 --silent -X -POST -d 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}' http://192.168.12.139/rpc | jq -r '.''
Jan 16 07:06:43 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Jan 16 07:06:43 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Jan 16 07:06:43 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Jan 16 07:06:43 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 1.1° - 56.9%
Jan 16 07:06:43 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/01/shelly-39_20240116.csv'
Jan 16 07:06:43 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 1.1°/1.1° - 56.9%/61.8% - SAVED
Jan 16 07:06:43 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: batt='100'°
Jan 16 07:06:43 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: dweetIO='{#012 "this": "succeeded",#012 "by": "dweeting",#012 "the": "dweet",#012 "with": {#012 "thing": "viehai-39",#012 "created": "2024-01-16T06:06:43.732Z",#012 "content": {#012 "temp": 1.1,#012 "hum": 56.9,#012 "batt": 100#012 },#012 "transaction": "2096e78b-890f-426f-afc3-1c0bede64a9b"#012 }#012}'°
Jan 16 07:06:55 srv4hai activate_scenario.sh: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED
Jan 16 07:06:55 srv4hai postfix/pickup[15282]: 2D3B460244: uid=33 from=
Jan 16 07:06:55 srv4hai postfix/cleanup[27547]: 2D3B460244: message-id=<20240116060655.2D3B460244@mail.viehai.at>
Jan 16 07:06:55 srv4hai postfix/qmgr[28610]: 2D3B460244: from=, size=13813, nrcpt=1 (queue active)
Jan 16 07:06:55 srv4hai postfix/local[27561]: 2D3B460244: to=, orig_to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 16 07:06:55 srv4hai postfix/cleanup[27547]: 3186260245: message-id=<20240116060655.3186260245@mail.viehai.at>
Jan 16 07:06:55 srv4hai postfix/bounce[27566]: 2D3B460244: sender non-delivery notification: 3186260245
Jan 16 07:06:55 srv4hai postfix/qmgr[28610]: 3186260245: from=<>, size=15692, nrcpt=1 (queue active)
Jan 16 07:06:55 srv4hai postfix/qmgr[28610]: 2D3B460244: removed
Jan 16 07:06:55 srv4hai postfix/local[27561]: 3186260245: to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 16 07:06:55 srv4hai postfix/qmgr[28610]: 3186260245: removed
Jan 16 07:06:55 srv4hai activate_scenario.sh: SHELLY: 'shelly-08'-'Thomas Büro Regallicht' --> '0?turn=toggle'
Jan 16 07:06:55 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/16/_0.log' - shellyUsage:'Thomas Büro Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'noHandy'
Jan 16 07:06:55 srv4hai activate_scenario.sh: SHELLY: 'shelly-40'-'Thomas Büro Licht' --> '0?turn=toggle'
Jan 16 07:06:55 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/16/_1.log' - shellyUsage:'Thomas Büro Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'noHandy'
Jan 16 07:06:55 srv4hai activate_scenario.sh: SHELLY scenario: 'buero_UM(buero_um)' took 139 msec
Jan 16 07:06:55 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.108/status'
Jan 16 07:06:55 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.108","rssi":-62},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"07:06","unixtime":1705385215,"serial":1,"has_update":false,"mac":"8CAAB56203DF","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"relays":[{"ison":false,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"source":"http"}],"meters":[{"power":0.00,"is_valid":true}],"inputs":[{"input":1,"event":"","event_cnt":0}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"update":{"status":"idle","has_update":false,"new_version":"20230913-112003/v1.14.0-gcb84623","old_version":"20230913-112003/v1.14.0-gcb84623","beta_version":"20231107-162940/v1.14.1-rc1-g0617c15"},"ram_total":51688,"ram_free":40364,"fs_size":233681,"fs_free":150600,"uptime":6453406}'
Jan 16 07:06:55 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.140/status'
Jan 16 07:06:55 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.140","rssi":-63},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"07:06","unixtime":1705385215,"serial":752,"has_update":false,"mac":"98CDAC307B4F","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"relays":[{"ison":false,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"source":"http"}],"meters":[{"power":0.00,"is_valid":false,"timestamp":1705388815,"counters":[0.000, 0.000, 0.000],"total":0}],"inputs":[{"input":0,"event":"S","event_cnt":305},{"input":0,"event":"","event_cnt":0}],"temperature":44.84,"overtemperature":false,"tmp":{"tC":44.84,"tF":112.72,"is_valid":true},"update":{"status":"idle","has_update":false,"new_version":"20230913-112054/v1.14.0-gcb84623","old_version":"20230913-112054/v1.14.0-gcb84623","beta_version":"20231107-163031/v1.14.1-rc1-g0617c15"},"ram_total":51912,"ram_free":36748,"fs_size":233681,"fs_free":162648,"uptime":6453351}'
Jan 16 07:07:01 srv4hai CRON[27907]: (root) CMD (/etc/linetest/linetest.sh)
Jan 16 07:07:01 srv4hai named[14530]: resolver priming query complete
Jan 16 07:07:08 srv4hai named[14530]: resolver priming query complete
Jan 16 07:07:10 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705385230 - 'ping_SP_0'
Jan 16 07:07:14 srv4hai dhcpd[8095]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan 16 07:07:14 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
finished