activate_scenario.sh
Sun Apr 21 09:27:59 CEST 2024
scenario: vorraumOn
phoneName: 2

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

scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

Licht Vorzimmer (/srv/www/viehai/shelly/log_scenarios/2024/04/21/_0.log)

vorher: 09:28:00.047

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: 09:28:00.153
Dauer: 105 msec phName: 'phoneName:'2''


scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

urls : 1
vorher : 09:28:00.025
nachher: 09:28:00.159
Dauer : 134 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/04/21//scene_vorraumOn_20240421_092759.txt'


syslog

Apr 21 09:24:01 srv4hai CRON[10266]: (root) CMD (/etc/linetest/linetest.sh)
Apr 21 09:24:36 srv4hai ping_SP[956]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1713684276 - 'ping_SP_1'
Apr 21 09:24:36 srv4hai ping_SP[956]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 21 09:24:37 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=10317, secured, session=
Apr 21 09:24:37 srv4hai dovecot: imap(miglincit)<10317>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 21 09:24:50 srv4hai ping_SP[10475]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1713684290 - 'ping_SP_0'
Apr 21 09:24:50 srv4hai ping_SP[10475]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 21 09:25:01 srv4hai sntp[10353]: sntp 4.2.8p12@1.3728-o (1)
Apr 21 09:25:01 srv4hai sntp[10353]: 2024-04-21 09:25:01.123436 (-0100) -0.003587 +/- 0.002467 time.google.com 216.239.35.0 s1 no-leap
Apr 21 09:25:01 srv4hai CRON[10358]: (root) CMD (/etc/linetest/linetest.sh)
Apr 21 09:25:16 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Apr 21 09:25:17 srv4hai fetchmail[1651]: 42591 messages (42590 seen) for tmiglinci at mail.akis.at (-748703181 octets).
Apr 21 09:25:17 srv4hai postfix/smtpd[10375]: connect from localhost[127.0.0.1]
Apr 21 09:25:17 srv4hai postfix/smtpd[10375]: 8F5006011D: client=localhost[127.0.0.1]
Apr 21 09:25:17 srv4hai postfix/cleanup[10378]: 8F5006011D: message-id=
Apr 21 09:25:17 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:42591 of 42591 (125122 octets) not flushed
Apr 21 09:25:17 srv4hai postfix/qmgr[15291]: 8F5006011D: from=, size=125371, nrcpt=1 (queue active)
Apr 21 09:25:17 srv4hai postfix/smtpd[10375]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Apr 21 09:25:17 srv4hai postfix/local[10379]: 8F5006011D: to=, relay=local, delay=0.09, delays=0.07/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Apr 21 09:25:17 srv4hai postfix/qmgr[15291]: 8F5006011D: removed
Apr 21 09:25:18 srv4hai fetchmail[1651]: 10158 messages (10158 seen) for srozum at mail.akis.at (1226622622 octets).
Apr 21 09:25:18 srv4hai fetchmail[1651]: 22998 messages (22998 seen) for mrozum at mail.akis.at (-309874507 octets).
Apr 21 09:25:18 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Apr 21 09:25:49 srv4hai ping_SP[956]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1713684349 - 'ping_SP_1'
Apr 21 09:25:49 srv4hai ping_SP[956]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 21 09:26:01 srv4hai CRON[10426]: (root) CMD (/etc/linetest/linetest.sh)
Apr 21 09:26:03 srv4hai ping_SP[10475]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1713684363 - 'ping_SP_0'
Apr 21 09:26:03 srv4hai ping_SP[10475]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 21 09:26:28 srv4hai postfix/anvil[10186]: statistics: max connection rate 1/60s for (smtp:193.222.96.12) at Apr 21 09:23:07
Apr 21 09:26:28 srv4hai postfix/anvil[10186]: statistics: max connection count 1 for (smtp:193.222.96.12) at Apr 21 09:23:07
Apr 21 09:26:28 srv4hai postfix/anvil[10186]: statistics: max cache size 1 at Apr 21 09:23:07
Apr 21 09:26:50 srv4hai dhcpd[22856]: DHCPDISCOVER from c0:49:ef:8a:c9:d8 via enp2s0
Apr 21 09:26:50 srv4hai dhcpd[22856]: DHCPOFFER on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Apr 21 09:26:50 srv4hai dhcpd[22856]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Apr 21 09:26:50 srv4hai dhcpd[22856]: execute_statement argv[1] = 192.168.12.139
Apr 21 09:26:50 srv4hai dhcpd[22856]: execute_statement argv[2] = shelly-39
Apr 21 09:26:50 srv4hai dhcpd[22856]: DHCPREQUEST for 192.168.12.139 (192.168.12.252) from c0:49:ef:8a:c9:d8 via enp2s0
Apr 21 09:26:50 srv4hai dhcpd[22856]: DHCPACK on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Apr 21 09:26:50 srv4hai named[15509]: client @0x7f93100017f0 192.168.12.252#43371/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-39.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 21 09:26:50 srv4hai named[15509]: client @0x7f931c100b10 192.168.12.252#33343/key rndc-key: signer "rndc-key" approved
Apr 21 09:26:50 srv4hai named[15509]: client @0x7f931c100b10 192.168.12.252#33343/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' TXT
Apr 21 09:26:50 srv4hai named[15509]: client @0x7f931c100b10 192.168.12.252#33343/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' TXT "314be662bb43914e78b269d3f3bc9f38c7"
Apr 21 09:26:50 srv4hai named[15509]: client @0x7f931c100b10 192.168.12.252#33343/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' A
Apr 21 09:26:50 srv4hai named[15509]: client @0x7f931c100b10 192.168.12.252#33343/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' A 192.168.12.139
Apr 21 09:26:50 srv4hai dhcpd[22856]: Added new forward map from shelly-39.viehai.at to 192.168.12.139
Apr 21 09:26:50 srv4hai named[15509]: client @0x7f9314001390 192.168.12.252#36949/key rndc-key: signer "rndc-key" approved
Apr 21 09:26:50 srv4hai named[15509]: client @0x7f9314001390 192.168.12.252#36949/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '139.12.168.192.in-addr.arpa' PTR
Apr 21 09:26:50 srv4hai named[15509]: client @0x7f9314001390 192.168.12.252#36949/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.
Apr 21 09:26:50 srv4hai dhcpd[22856]: Added reverse map from 139.12.168.192.in-addr.arpa. to shelly-39.viehai.at
Apr 21 09:26:50 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-39' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Apr 21 09:26:50 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Apr 21 09:26:50 srv4hai common[10503]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Apr 21 09:26:50 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: gen=2&temp=6&hum=61.800000&id=C049EF8AC9D8&batt=100&volt=6.660000
Apr 21 09:26:50 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2024/04/shelly-39_20240421.csv'
Apr 21 09:26:50 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Apr 21 09:26:50 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Apr 21 09:26:50 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}'
Apr 21 09:26:50 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Apr 21 09:26:50 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}'
Apr 21 09:26:50 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 '.''
Apr 21 09:26:50 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Apr 21 09:26:50 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 '.''
Apr 21 09:26:50 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Apr 21 09:26:50 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Apr 21 09:26:50 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Apr 21 09:26:50 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 6° - 61.8%
Apr 21 09:26:50 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 6°/5.5° - 61.8%/65.2% - SAVED
Apr 21 09:26:50 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: batt='100'°
Apr 21 09:26:51 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-04-21T07:26:51.064Z",#012    "content": {#012      "temp": 6,#012      "hum": 61.8,#012      "batt": 100,#012      "csvF": "shelly-39_20240421.csv"#012    },#012    "transaction": "4c865618-17bf-4f4a-a687-612fae39b0a8"#012  }#012}'°
Apr 21 09:27:01 srv4hai CRON[10660]: (root) CMD (/etc/linetest/linetest.sh)
Apr 21 09:27:03 srv4hai ping_SP[956]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1713684423 - 'ping_SP_1'
Apr 21 09:27:03 srv4hai ping_SP[956]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 21 09:27:17 srv4hai ping_SP[10475]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1713684437 - 'ping_SP_0'
Apr 21 09:27:17 srv4hai ping_SP[10475]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 21 09:27:37 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=10728, secured, session=<5PtdQZYWHroAAAAAAAAAAAAAAAAAAAAB>
Apr 21 09:27:37 srv4hai dovecot: imap(miglincit)<10728><5PtdQZYWHroAAAAAAAAAAAAAAAAAAAAB>: Logged out in=546 out=41224 deleted=0 expunged=0 trashed=0 hdr_count=50 hdr_bytes=17059 body_count=0 body_bytes=0
Apr 21 09:27:49 srv4hai common[10736]: SHELLY common.sh inkludiert von ./bt_scan.sh
Apr 21 09:27:58 srv4hai dhcpd[22856]: DHCPDISCOVER from 84:cc:a8:a8:55:7d via enp2s0
Apr 21 09:27:58 srv4hai dhcpd[22856]: DHCPOFFER on 192.168.12.102 to 84:cc:a8:a8:55:7d via enp2s0
Apr 21 09:27:58 srv4hai dhcpd[22856]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Apr 21 09:27:58 srv4hai dhcpd[22856]: execute_statement argv[1] = 192.168.12.102
Apr 21 09:27:58 srv4hai dhcpd[22856]: execute_statement argv[2] = shelly-02
Apr 21 09:27:58 srv4hai dhcpd[22856]: DHCPREQUEST for 192.168.12.102 (192.168.12.252) from 84:cc:a8:a8:55:7d via enp2s0
Apr 21 09:27:58 srv4hai dhcpd[22856]: DHCPACK on 192.168.12.102 to 84:cc:a8:a8:55:7d via enp2s0
Apr 21 09:27:58 srv4hai named[15509]: client @0x7f930805ddf0 192.168.12.252#33763/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-02.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 21 09:27:58 srv4hai named[15509]: client @0x7f93040506c0 192.168.12.252#52033/key rndc-key: signer "rndc-key" approved
Apr 21 09:27:58 srv4hai named[15509]: client @0x7f93040506c0 192.168.12.252#52033/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-02.viehai.at' TXT
Apr 21 09:27:58 srv4hai named[15509]: client @0x7f93040506c0 192.168.12.252#52033/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-02.viehai.at' TXT "005dc8ffbb18e92d4c1a5981a9354b73fe"
Apr 21 09:27:58 srv4hai named[15509]: client @0x7f93040506c0 192.168.12.252#52033/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-02.viehai.at' A
Apr 21 09:27:58 srv4hai named[15509]: client @0x7f93040506c0 192.168.12.252#52033/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-02.viehai.at' A 192.168.12.102
Apr 21 09:27:58 srv4hai dhcpd[22856]: Added new forward map from shelly-02.viehai.at to 192.168.12.102
Apr 21 09:27:58 srv4hai named[15509]: client @0x7f931406e6c0 192.168.12.252#58611/key rndc-key: signer "rndc-key" approved
Apr 21 09:27:58 srv4hai named[15509]: client @0x7f931406e6c0 192.168.12.252#58611/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '102.12.168.192.in-addr.arpa' PTR
Apr 21 09:27:58 srv4hai named[15509]: client @0x7f931406e6c0 192.168.12.252#58611/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '102.12.168.192.in-addr.arpa' PTR shelly-02.viehai.at.
Apr 21 09:27:58 srv4hai dhcpd[22856]: Added reverse map from 102.12.168.192.in-addr.arpa. to shelly-02.viehai.at
Apr 21 09:27:58 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-02' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Apr 21 09:27:59 srv4hai bt_scan[10736]: SHELLY - who: 'Sophie' / phoneName: 'iP_Sophie' / '2' / shellyIP: '192.168.12.63' - found: 'Yes'
Apr 21 09:27:59 srv4hai bt_scan[10736]: SHELLY - ping_SP.sh started for BTmac: '2' - IPv4: '192.168.12.63'
Apr 21 09:27:59 srv4hai common[10781]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Apr 21 09:27:59 srv4hai ping_SP[10781]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Apr 21 09:27:59 srv4hai common[10802]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Apr 21 09:27:59 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1713684479-1713684469
Apr 21 09:27:59 srv4hai check_presence[10802]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Apr 21 09:27:59 srv4hai check_presence[10802]: SHELLY (ping_SP__bt_scan)-(2) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Apr 21 09:27:59 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'10'=1713684479-1713684469
Apr 21 09:27:59 srv4hai check_presence[10802]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Apr 21 09:27:59 srv4hai check_presence[10802]: SHELLY (ping_SP__bt_scan)-(2) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Apr 21 09:27:59 srv4hai common.sh: SHELLY: BTstatus[2]:'On' dweetAge:'10'=1713684479-1713684469
Apr 21 09:27:59 srv4hai check_presence[10802]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_2.Yes
Apr 21 09:27:59 srv4hai check_presence[10802]: SHELLY (ping_SP__bt_scan)-(2) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE) (BT/__)' - anyPresent: 'true' - otherPresent:'true'
Apr 21 09:27:59 srv4hai check_presence[10802]: SHELLY (ping_SP__bt_scan)-(2)-coming: activate_scenario.shtml: vorraumOn
Apr 21 09:27:59 srv4hai activate_scenario[10923]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Apr 21 09:27:59 srv4hai activate_scenario[10923]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'2'
Apr 21 09:27:59 srv4hai mosquitto[18551]: New connection from 192.168.12.102 on port 1883.

finished