activate_scenario.sh
Sun Mar 31 14:51:18 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/03/31/_0.log)

vorher: 14:51:18.588

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: 14:51:18.613
Dauer: 25 msec phName: 'phoneName:'2''


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

urls : 1
vorher : 14:51:18.570
nachher: 14:51:18.620
Dauer : 50 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/03/31//scene_vorraumOn_20240331_145118.txt'


syslog

Mar 31 14:48:01 srv4hai CRON[31795]: (root) CMD (/etc/linetest/linetest.sh)
Mar 31 14:48:41 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1711889321 - 'ping_SP_0'
Mar 31 14:48:41 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 31 14:48:53 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=31833, secured, session=
Mar 31 14:48:53 srv4hai dovecot: imap(miglincit)<31833>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 31 14:49:01 srv4hai CRON[31837]: (root) CMD (/etc/linetest/linetest.sh)
Mar 31 14:49:18 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar 31 14:49:18 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.28
Mar 31 14:49:18 srv4hai dhcpd[5037]: execute_statement argv[2] = harmonyhub
Mar 31 14:49:18 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.28 from c8:db:26:0c:f3:8e via enp2s0
Mar 31 14:49:18 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Mar 31 14:49:18 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#59901/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: harmonyhub.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 31 14:49:18 srv4hai named[15509]: client @0x7f93180334d0 192.168.12.252#60189/key rndc-key: signer "rndc-key" approved
Mar 31 14:49:18 srv4hai named[15509]: client @0x7f93180334d0 192.168.12.252#60189/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' TXT
Mar 31 14:49:18 srv4hai named[15509]: client @0x7f93180334d0 192.168.12.252#60189/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' TXT "3122b5a8b4281156e6f217b32b7e260713"
Mar 31 14:49:18 srv4hai named[15509]: client @0x7f93180334d0 192.168.12.252#60189/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' A
Mar 31 14:49:18 srv4hai named[15509]: client @0x7f93180334d0 192.168.12.252#60189/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' A 192.168.12.28
Mar 31 14:49:18 srv4hai dhcpd[5037]: Added new forward map from harmonyhub.viehai.at to 192.168.12.28
Mar 31 14:49:18 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.28'(28) device 'harmonyhub'
Mar 31 14:49:18 srv4hai named[15509]: client @0x7f930c06d910 192.168.12.252#53857/key rndc-key: signer "rndc-key" approved
Mar 31 14:49:18 srv4hai named[15509]: client @0x7f930c06d910 192.168.12.252#53857/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '28.12.168.192.in-addr.arpa' PTR
Mar 31 14:49:18 srv4hai named[15509]: client @0x7f930c06d910 192.168.12.252#53857/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.
Mar 31 14:49:18 srv4hai dhcpd[5037]: Added reverse map from 28.12.168.192.in-addr.arpa. to harmonyhub.viehai.at
Mar 31 14:49:18 srv4hai dhcpcommit.sh: SHELLY device 'harmonyhub' known and accepted
Mar 31 14:49:27 srv4hai common[31852]: SHELLY common.sh inkludiert
Mar 31 14:49:37 srv4hai bt_scan[31852]: SHELLY - who: 'Sophie' / phoneName: 'iP_Sophie' / '2' / fixAddr: '192.168.12.63;' - found: 'No'
Mar 31 14:49:37 srv4hai bt_scan[31852]: SHELLY - lost BT-connection to BTmac: '2' found: 'No' - check presence
Mar 31 14:49:37 srv4hai common[31881]: SHELLY common.sh inkludiert
Mar 31 14:49:38 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'1'=1711889378-1711889377
Mar 31 14:49:38 srv4hai check_presence[31881]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Mar 31 14:49:38 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'1'=1711889378-1711889377
Mar 31 14:49:38 srv4hai check_presence[31881]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Mar 31 14:49:38 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_not_set' dweetAge:'1'=1711889378-1711889377
Mar 31 14:49:38 srv4hai check_presence[31881]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Mar 31 14:49:38 srv4hai check_presence[31881]: SHELLY (bt_scan)-(2) what: 'presence' - persPresent: '(__/IP) (__/IP) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Mar 31 14:49:38 srv4hai check_presence[31881]: SHELLY (bt_scan)-(2)-presence: NOT activate_scenario.shtml: offAll
Mar 31 14:49:54 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1711889394 - 'ping_SP_0'
Mar 31 14:49:54 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 31 14:49:56 srv4hai dhcpd[5037]: DHCPDISCOVER from 30:83:98:8c:05:9d via enp2s0
Mar 31 14:49:56 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.123 to 30:83:98:8c:05:9d via enp2s0
Mar 31 14:49:56 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Mar 31 14:49:56 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.123
Mar 31 14:49:56 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-23
Mar 31 14:49:56 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.123 (192.168.12.252) from 30:83:98:8c:05:9d via enp2s0
Mar 31 14:49:56 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.123 to 30:83:98:8c:05:9d via enp2s0
Mar 31 14:49:56 srv4hai named[15509]: client @0x7f931c6d4af0 192.168.12.252#41329/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-23.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 31 14:49:56 srv4hai named[15509]: client @0x7f930801c730 192.168.12.252#52419/key rndc-key: signer "rndc-key" approved
Mar 31 14:49:56 srv4hai named[15509]: client @0x7f930801c730 192.168.12.252#52419/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-23.viehai.at' TXT
Mar 31 14:49:56 srv4hai named[15509]: client @0x7f930801c730 192.168.12.252#52419/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-23.viehai.at' TXT "0067c4eae5f3400bd02ff9ebe320262416"
Mar 31 14:49:56 srv4hai named[15509]: client @0x7f930801c730 192.168.12.252#52419/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-23.viehai.at' A
Mar 31 14:49:56 srv4hai named[15509]: client @0x7f930801c730 192.168.12.252#52419/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-23.viehai.at' A 192.168.12.123
Mar 31 14:49:56 srv4hai dhcpd[5037]: Added new forward map from shelly-23.viehai.at to 192.168.12.123
Mar 31 14:49:56 srv4hai named[15509]: client @0x7f930c069dc0 192.168.12.252#36587/key rndc-key: signer "rndc-key" approved
Mar 31 14:49:56 srv4hai named[15509]: client @0x7f930c069dc0 192.168.12.252#36587/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '123.12.168.192.in-addr.arpa' PTR
Mar 31 14:49:56 srv4hai named[15509]: client @0x7f930c069dc0 192.168.12.252#36587/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '123.12.168.192.in-addr.arpa' PTR shelly-23.viehai.at.
Mar 31 14:49:56 srv4hai dhcpd[5037]: Added reverse map from 123.12.168.192.in-addr.arpa. to shelly-23.viehai.at
Mar 31 14:49:56 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-23' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Mar 31 14:49:58 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-23' - shIP/2:'192.168.12.123'
Mar 31 14:49:58 srv4hai conf_shelly.sh: SHELLY: usage/name 'Licht Sekretär' already set for '192.168.12.123'
Mar 31 14:49:58 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(0)' - allready transmitted - skipping
Mar 31 14:49:58 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(1)' - allready transmitted - skipping
Mar 31 14:49:58 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(2)' - allready transmitted - skipping
Mar 31 14:49:58 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(3)' - allready transmitted - skipping
Mar 31 14:49:58 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(4)' - allready transmitted - skipping
Mar 31 14:49:58 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(5)' - allready transmitted - skipping
Mar 31 14:49:58 srv4hai conf_shelly.sh: SHELLY:'shelly-23' out:0 ON : MISSING
Mar 31 14:49:58 srv4hai conf_shelly.sh: SHELLY:'shelly-23' out:0 OFF: MISSING
Mar 31 14:50:01 srv4hai CRON[32125]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Mar 31 14:50:01 srv4hai CRON[32126]: (root) CMD (/etc/linetest/linetest.sh)
Mar 31 14:50:01 srv4hai common[32127]: SHELLY common.sh inkludiert
Mar 31 14:50:01 srv4hai meter.sh: SHELLY meter.sh started
Mar 31 14:50:02 srv4hai meter.sh: SHELLY 'shelly-29/Schalter Herdzeile' - type: 'shelly-i3' ignoring
Mar 31 14:50:02 srv4hai meter.sh: SHELLY 'shelly-28/Schalter Nasszeile' - type: 'shelly-i3' ignoring
Mar 31 14:50:05 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster' - type: 'shelly-BTN' ignoring
Mar 31 14:50:05 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter' - type: 'shelly-BTN' ignoring
Mar 31 14:50:05 srv4hai meter.sh: SHELLY 'shelly-37/Klima Büro' - type: 'shelly-ht' ignoring
Mar 31 14:50:05 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen' - status: 'OOS' ignoring
Mar 31 14:50:05 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon' - type: 'shelly-ht-plus' ignoring
Mar 31 14:50:08 srv4hai meter.sh: SHELLY 'shelly-58/Werkstatt Licht':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 31 14:50:08 srv4hai meter.sh: SHELLY 'shelly-59/Werkstatt Schalter Kellertür' - type: 'shelly-i3' ignoring
Mar 31 14:50:10 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 31 14:50:13 srv4hai meter.sh: SHELLY 'shelly-15/15-Test Weiss':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 31 14:50:13 srv4hai meter.sh: SHELLY 'shelly-30/30-TBD' - status: 'OOS' ignoring
Mar 31 14:50:13 srv4hai meter.sh: SHELLY 'shelly-31/31-Test i3' - status: 'OOS' ignoring
Mar 31 14:50:13 srv4hai meter.sh: SHELLY 'shelly-32/32-TBD' - status: 'OOS' ignoring
Mar 31 14:50:13 srv4hai meter.sh: SHELLY 'shelly-33/33-TBD' - status: 'OOS' ignoring
Mar 31 14:50:13 srv4hai meter.sh: SHELLY 'shelly-36/36-TBD' - status: 'OOS' ignoring
Mar 31 14:50:16 srv4hai meter.sh: SHELLY 'shelly-47/47-plus1-Test':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 31 14:50:16 srv4hai meter.sh: SHELLY 'shelly-09a/Inbetriebnahme - 20210720 - Defekt' - status: 'defect' ignoring
Mar 31 14:50:16 srv4hai meter.sh: SHELLY 'shelly-09b/Sophie Licht - 20230404 - Defekt' - status: 'defect' ignoring
Mar 31 14:50:16 srv4hai meter.sh: SHELLY 'shelly-26/20230404 - kein WLAN' - status: 'defect' ignoring
Mar 31 14:50:16 srv4hai meter.sh: SHELLY 'shelly-27/Schalter Herdzeile - Defekt WLAN 20230417' - status: 'defect' ignoring
Mar 31 14:50:16 srv4hai meter.sh: SHELLY 'shelly-21/Badezimmer - 20230720 - WLAN Problem' - status: 'defect' ignoring
Mar 31 14:50:16 srv4hai meter.sh: SHELLY 'shelly-11/Ausgangstransistor defekt 20230722' - status: 'defect' ignoring
Mar 31 14:50:16 srv4hai meter.sh: SHELLY 'shelly-43/43-TBD' - status: 'OOS' ignoring
Mar 31 14:50:16 srv4hai meter.sh: SHELLY 'shelly-44/44-TBD' - status: 'OOS' ignoring
Mar 31 14:50:16 srv4hai meter.sh: SHELLY 'shelly-45/45-TBD' - status: 'OOS' ignoring
Mar 31 14:50:16 srv4hai common[32127]: SHELLY common.sh inkludiert
Mar 31 14:50:16 srv4hai check_shelly.sh: SHELLY last scenery executed: 'vorraumOn'
Mar 31 14:50:16 srv4hai check_shelly.sh: SHELLY found '10' active shelly outputs
Mar 31 14:50:16 srv4hai meter.sh: SHELLY meter.sh ended
Mar 31 14:50:16 srv4hai postfix/pickup[18051]: B273460245: uid=33 from=
Mar 31 14:50:16 srv4hai postfix/cleanup[555]: B273460245: message-id=<20240331125016.B273460245@mail.viehai.at>
Mar 31 14:50:16 srv4hai postfix/qmgr[15291]: B273460245: from=, size=895, nrcpt=1 (queue active)
Mar 31 14:50:16 srv4hai postfix/local[557]: B273460245: to=, orig_to=, relay=local, delay=0.04, delays=0.02/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 31 14:50:16 srv4hai postfix/qmgr[15291]: B273460245: removed
Mar 31 14:50:48 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=565, secured, session=<1ft0UvQUTMYAAAAAAAAAAAAAAAAAAAAB>
Mar 31 14:50:48 srv4hai dovecot: imap(miglincit)<565><1ft0UvQUTMYAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 31 14:51:01 srv4hai CRON[572]: (root) CMD (/etc/linetest/linetest.sh)
Mar 31 14:51:02 srv4hai dhcpd[5037]: DHCPDISCOVER from ce:02:e3:29:83:19 via enp2s0
Mar 31 14:51:02 srv4hai dhcpd[5037]: unexpected ICMP Echo Reply from 95.129.201.1
Mar 31 14:51:02 srv4hai dhcpd[5037]: unexpected ICMP Echo Reply from 8.8.8.8
Mar 31 14:51:03 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.35 to ce:02:e3:29:83:19 via enp2s0
Mar 31 14:51:03 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.35 (192.168.12.252) from ce:02:e3:29:83:19 via enp2s0
Mar 31 14:51:03 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.35 to ce:02:e3:29:83:19 via enp2s0
Mar 31 14:51:07 srv4hai common[581]: SHELLY common.sh inkludiert
Mar 31 14:51:07 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1711889467 - 'ping_SP_0'
Mar 31 14:51:07 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 31 14:51:17 srv4hai bt_scan[581]: SHELLY - who: 'Sophie' / phoneName: 'iP_Sophie' / '2' / fixAddr: '192.168.12.63;' - found: 'Yes'
Mar 31 14:51:17 srv4hai bt_scan[581]: SHELLY - ping_SP.sh started for BTmac: '2' - IPv4: '192.168.12.63'
Mar 31 14:51:17 srv4hai common[624]: SHELLY common.sh inkludiert
Mar 31 14:51:17 srv4hai ping_SP[624]: SHELLY ping_SP.sh started from bt_scan
Mar 31 14:51:17 srv4hai common[634]: SHELLY common.sh inkludiert
Mar 31 14:51:18 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'11'=1711889478-1711889467
Mar 31 14:51:18 srv4hai check_presence[634]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Mar 31 14:51:18 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'11'=1711889478-1711889467
Mar 31 14:51:18 srv4hai check_presence[634]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Mar 31 14:51:18 srv4hai common.sh: SHELLY: BTstatus[2]:'On' dweetAge:'11'=1711889478-1711889467
Mar 31 14:51:18 srv4hai check_presence[634]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and On//srv/www/viehai/shelly//meter/BTscan_BTid_2.Yes
Mar 31 14:51:18 srv4hai check_presence[634]: SHELLY (ping_SP__bt_scan)-(2) what: 'coming' - persPresent: '(BT/IP) (BT/IP) (BT/__)' - anyPresent: 'true' - otherPresent:'true'
Mar 31 14:51:18 srv4hai check_presence[634]: SHELLY (ping_SP__bt_scan)-(2)-coming: activate_scenario.shtml: vorraumOn
Mar 31 14:51:18 srv4hai activate_scenario[742]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Mar 31 14:51:18 srv4hai activate_scenario[742]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'2'

finished