activate_scenario.sh
Thu Feb 22 20:27:41 CET 2024
scenario: welcomeLight
phoneName: 2

'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/02/22/_0.log)

vorher: 20:27:41.671

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": "http"

nachher: 20:27:41.773
Dauer: 102 msec phName: 'phoneName:'2''

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

vorher: 20:27:41.686

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

nachher: 20:27:41.773
Dauer: 88 msec phName: 'phoneName:'2''

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

vorher: 20:27:41.700

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

nachher: 20:27:41.772
Dauer: 73 msec phName: 'phoneName:'2''

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

vorher: 20:27:41.714

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

nachher: 20:27:41.784
Dauer: 70 msec phName: 'phoneName:'2''

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

vorher: 20:27:41.729

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

nachher: 20:27:41.829
Dauer: 101 msec phName: 'phoneName:'2''

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

urls : 5
vorher : 20:27:41.644
nachher: 20:27:41.838
Dauer : 194 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/02/22//scene_welcomeLight_20240222_202741.txt'

syslog

Feb 22 20:24:01 srv4hai CRON[17594]: (root) CMD (/etc/linetest/linetest.sh)
Feb 22 20:24:10 srv4hai ping_SP[21651]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1708629850 - 'ping_SP_1'
Feb 22 20:24:10 srv4hai ping_SP[21651]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Feb 22 20:24:39 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=17632, secured, session=
Feb 22 20:24:39 srv4hai dovecot: imap(rozumm)<17632>: Logged out in=92 out=1059 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 22 20:24:44 srv4hai postfix/anvil[17381]: statistics: max connection rate 1/60s for (smtp:193.222.96.116) at Feb 22 20:21:24
Feb 22 20:24:44 srv4hai postfix/anvil[17381]: statistics: max connection count 1 for (smtp:193.222.96.116) at Feb 22 20:21:24
Feb 22 20:24:44 srv4hai postfix/anvil[17381]: statistics: max cache size 1 at Feb 22 20:21:24
Feb 22 20:25:01 srv4hai sntp[17646]: sntp 4.2.8p12@1.3728-o (1)
Feb 22 20:25:01 srv4hai sntp[17646]: 2024-02-22 20:25:01.102400 (-0100) +0.001412 +/- 0.001002 time.google.com 216.239.35.8 s1 no-leap
Feb 22 20:25:01 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=17651, secured, session=
Feb 22 20:25:01 srv4hai dovecot: imap(miglincit)<17651>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 22 20:25:01 srv4hai CRON[17653]: (root) CMD (/etc/linetest/linetest.sh)
Feb 22 20:25:06 srv4hai dhcpd[5037]: DHCPDISCOVER from 48:55:19:00:b3:58 via enp2s0
Feb 22 20:25:06 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.137 to 48:55:19:00:b3:58 via enp2s0
Feb 22 20:25:06 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Feb 22 20:25:06 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.137
Feb 22 20:25:06 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-37
Feb 22 20:25:06 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.137 (192.168.12.252) from 48:55:19:00:b3:58 via enp2s0
Feb 22 20:25:06 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.137 to 48:55:19:00:b3:58 via enp2s0
Feb 22 20:25:06 srv4hai named[14530]: client @0x7fc3140ea1f0 192.168.12.252#50701/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-37.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 22 20:25:06 srv4hai named[14530]: client @0x7fc3100cb8b0 192.168.12.252#55075/key rndc-key: signer "rndc-key" approved
Feb 22 20:25:06 srv4hai named[14530]: client @0x7fc3100cb8b0 192.168.12.252#55075/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-37.viehai.at' TXT
Feb 22 20:25:06 srv4hai named[14530]: client @0x7fc3100cb8b0 192.168.12.252#55075/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-37.viehai.at' TXT "001bc21ebc20088cb6a311248591ab7101"
Feb 22 20:25:06 srv4hai named[14530]: client @0x7fc3100cb8b0 192.168.12.252#55075/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-37.viehai.at' A
Feb 22 20:25:06 srv4hai named[14530]: client @0x7fc3100cb8b0 192.168.12.252#55075/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-37.viehai.at' A 192.168.12.137
Feb 22 20:25:06 srv4hai dhcpd[5037]: Added new forward map from shelly-37.viehai.at to 192.168.12.137
Feb 22 20:25:06 srv4hai named[14530]: client @0x7fc3286414b0 192.168.12.252#41081/key rndc-key: signer "rndc-key" approved
Feb 22 20:25:06 srv4hai named[14530]: client @0x7fc3286414b0 192.168.12.252#41081/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '137.12.168.192.in-addr.arpa' PTR
Feb 22 20:25:06 srv4hai named[14530]: client @0x7fc3286414b0 192.168.12.252#41081/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '137.12.168.192.in-addr.arpa' PTR shelly-37.viehai.at.
Feb 22 20:25:06 srv4hai dhcpd[5037]: Added reverse map from 137.12.168.192.in-addr.arpa. to shelly-37.viehai.at
Feb 22 20:25:06 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-37' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-37' - shIP/2:'192.168.12.137'
Feb 22 20:25:07 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=22.38&id=shellyht-00B358
Feb 22 20:25:07 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240222.csv'
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-37' - shIP/2:'192.168.12.137'
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetter 1' already set for '192.168.12.137'
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(0)' - allready transmitted - skipping
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetter 1' already set for '192.168.12.137'
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(1)' - allready transmitted - skipping
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(0)' - allready transmitted - skipping
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(2)' - allready transmitted - skipping
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(1)' - allready transmitted - skipping
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(3)' - ''
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(2)' - allready transmitted - skipping
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(3)' - ''
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY:'shelly-37' conf(3)-cmd: 'curl --connect-timeout 3 --silent 'http://192.168.12.137/' | jq -r '.''
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY:'shelly-37' conf(3)-ret: ''
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY:'shelly-37' conf(3)-cmd: 'curl --connect-timeout 3 --silent 'http://192.168.12.137/' | jq -r '.''
Feb 22 20:25:07 srv4hai conf_shelly.sh: SHELLY:'shelly-37' conf(3)-ret: ''
Feb 22 20:25:07 srv4hai ht_shelly.sh: SHELLY shellyht-00B358 / shelly-37 / Wetter 1: 22.38° - 40%
Feb 22 20:25:07 srv4hai ht_shelly.sh: SHELLY shellyht-00B358 / shelly-37 / Wetter 1: 22.38°/22.5° - 40%/40% - SAVED
Feb 22 20:25:07 srv4hai ht_shelly.sh: SHELLY shellyht-00B358 / shelly-37 / Wetter 1: batt='91'°
Feb 22 20:25:07 srv4hai ht_shelly.sh: SHELLY shellyht-00B358 / shelly-37 / Wetter 1: dweetIO='{#012  "this": "succeeded",#012  "by": "dweeting",#012  "the": "dweet",#012  "with": {#012    "thing": "viehai-37",#012    "created": "2024-02-22T19:25:07.867Z",#012    "content": {#012      "temp": 22.38,#012      "hum": 40,#012      "batt": 91#012    },#012    "transaction": "dbf3f01d-d2d2-4e13-a0e1-4f66883e4b52"#012  }#012}'°
Feb 22 20:25:12 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=22.38&id=shellyht-00B358
Feb 22 20:25:12 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240222.csv'
Feb 22 20:25:12 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240222.csv' modifed 5s ago - EXIT
Feb 22 20:25:13 srv4hai ping_SP[21651]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1708629913 - 'ping_SP_1'
Feb 22 20:25:13 srv4hai ping_SP[21651]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Feb 22 20:25:17 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=22.38&id=shellyht-00B358
Feb 22 20:25:17 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240222.csv'
Feb 22 20:25:17 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240222.csv' modifed 10s ago - EXIT
Feb 22 20:25:22 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=22.38&id=shellyht-00B358
Feb 22 20:25:22 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240222.csv'
Feb 22 20:25:22 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240222.csv' modifed 15s ago - EXIT
Feb 22 20:25:27 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=22.38&id=shellyht-00B358
Feb 22 20:25:27 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240222.csv'
Feb 22 20:25:27 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240222.csv' modifed 20s ago - EXIT
Feb 22 20:25:32 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=22.38&id=shellyht-00B358
Feb 22 20:25:32 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240222.csv'
Feb 22 20:25:32 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240222.csv' modifed 25s ago - EXIT
Feb 22 20:25:39 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=18027, secured, session=
Feb 22 20:25:39 srv4hai dovecot: imap(rozumm)<18027>: Logged out in=92 out=1059 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 22 20:26:01 srv4hai CRON[18034]: (root) CMD (/etc/linetest/linetest.sh)
Feb 22 20:26:17 srv4hai ping_SP[21651]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1708629977 - 'ping_SP_1'
Feb 22 20:26:17 srv4hai ping_SP[21651]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Feb 22 20:26:39 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=18069, secured, session=
Feb 22 20:26:39 srv4hai dovecot: imap(rozumm)<18069>: Logged out in=92 out=1059 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 22 20:27:01 srv4hai CRON[18083]: (root) CMD (/etc/linetest/linetest.sh)
Feb 22 20:27:14 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Feb 22 20:27:14 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.28
Feb 22 20:27:14 srv4hai dhcpd[5037]: execute_statement argv[2] = harmonyhub
Feb 22 20:27:14 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.28 from c8:db:26:0c:f3:8e via enp2s0
Feb 22 20:27:14 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Feb 22 20:27:14 srv4hai named[14530]: client @0x7fc31c0c14b0 192.168.12.252#33213/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: harmonyhub.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 22 20:27:14 srv4hai named[14530]: client @0x7fc32405faa0 192.168.12.252#44751/key rndc-key: signer "rndc-key" approved
Feb 22 20:27:14 srv4hai named[14530]: client @0x7fc32405faa0 192.168.12.252#44751/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' TXT
Feb 22 20:27:14 srv4hai named[14530]: client @0x7fc32405faa0 192.168.12.252#44751/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' TXT "3122b5a8b4281156e6f217b32b7e260713"
Feb 22 20:27:14 srv4hai named[14530]: client @0x7fc32405faa0 192.168.12.252#44751/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' A
Feb 22 20:27:14 srv4hai named[14530]: client @0x7fc32405faa0 192.168.12.252#44751/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' A 192.168.12.28
Feb 22 20:27:14 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.28'(28) device 'harmonyhub'
Feb 22 20:27:14 srv4hai dhcpd[5037]: Added new forward map from harmonyhub.viehai.at to 192.168.12.28
Feb 22 20:27:14 srv4hai named[14530]: client @0x7fc31c0640a0 192.168.12.252#56921/key rndc-key: signer "rndc-key" approved
Feb 22 20:27:14 srv4hai named[14530]: client @0x7fc31c0640a0 192.168.12.252#56921/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '28.12.168.192.in-addr.arpa' PTR
Feb 22 20:27:14 srv4hai named[14530]: client @0x7fc31c0640a0 192.168.12.252#56921/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '28.12.168.192.in-addr.arpa' PTR harmonyhub.viehai.at.
Feb 22 20:27:14 srv4hai dhcpd[5037]: Added reverse map from 28.12.168.192.in-addr.arpa. to harmonyhub.viehai.at
Feb 22 20:27:14 srv4hai dhcpcommit.sh: SHELLY device 'harmonyhub' known and accepted
Feb 22 20:27:20 srv4hai ping_SP[21651]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1708630040 - 'ping_SP_1'
Feb 22 20:27:20 srv4hai ping_SP[21651]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Feb 22 20:27:39 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=18124, secured, session=
Feb 22 20:27:39 srv4hai dovecot: imap(rozumm)<18124>: Logged out in=92 out=1059 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 22 20:27:41 srv4hai common[18129]: SHELLY common.sh inkludiert
Feb 22 20:27:41 srv4hai bt_scan[18129]: SHELLY - who: 'Sophie' / phoneName: 'iP_Sophie' / '2' / fixAddr: '192.168.12.63;' - found: 'Yes'
Feb 22 20:27:41 srv4hai bt_scan[18129]: SHELLY - ping_SP.sh started for BTmac: '2' - IPv4: '192.168.12.63'
Feb 22 20:27:41 srv4hai common[18158]: SHELLY common.sh inkludiert
Feb 22 20:27:41 srv4hai ping_SP[18158]: SHELLY ping_SP.sh started from bt_scan
Feb 22 20:27:41 srv4hai common[18168]: SHELLY common.sh inkludiert
Feb 22 20:27:41 srv4hai check_presence[18168]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and /srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Feb 22 20:27:41 srv4hai check_presence[18168]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and /srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Feb 22 20:27:41 srv4hai check_presence[18168]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and /srv/www/viehai/shelly//meter/BTscan_BTid_2.Yes
Feb 22 20:27:41 srv4hai check_presence[18168]: SHELLY (ping_SP__bt_scan)-(2) what: 'coming' - persPresent: '(__/__) (BT/IP) (BT/__)' - anyPresent: 'true' - otherPresent:'true'
Feb 22 20:27:41 srv4hai check_presence[18168]: SHELLY (ping_SP__bt_scan)-(2)-coming: activate_scenario.shtml: welcomeLight
Feb 22 20:27:41 srv4hai activate_scenario[18221]: SHELLY scenario: 'welcomeLight(welcomelight)' started
Feb 22 20:27:41 srv4hai activate_scenario[18221]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'2'

finished