activate_scenario.sh
Thu Apr 18 20:43:05 CEST 2024
scenario: vorraumOn
phoneName: 1

'night' <--> 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/18/_0.log)

vorher: 20:43:05.236

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:43:05.300
Dauer: 64 msec phName: 'phoneName:'1''


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

urls : 1
vorher : 20:43:05.180
nachher: 20:43:05.306
Dauer : 128 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/04/18//scene_vorraumOn_20240418_204305.txt'


syslog

Apr 18 20:40:01 srv4hai CRON[5009]: (root) CMD (/etc/linetest/linetest.sh)
Apr 18 20:40:01 srv4hai CRON[5010]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Apr 18 20:40:01 srv4hai common[5011]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/meter.sh
Apr 18 20:40:01 srv4hai meter.sh: SHELLY meter.sh started
Apr 18 20:40:01 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=5026, secured, session=
Apr 18 20:40:01 srv4hai dovecot: imap(rozumm)<5026>: Logged out in=93 out=1063 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 18 20:40:01 srv4hai meter.sh: SHELLY 'shelly-29/Schalter Herdzeile' - type: 'shelly-i3' ignoring
Apr 18 20:40:01 srv4hai meter.sh: SHELLY 'shelly-28/Schalter Nasszeile' - type: 'shelly-i3' ignoring
Apr 18 20:40:05 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster' - type: 'shelly-BTN' ignoring
Apr 18 20:40:05 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter' - type: 'shelly-BTN' ignoring
Apr 18 20:40:05 srv4hai meter.sh: SHELLY 'shelly-37/Klima Büro' - type: 'shelly-ht' ignoring
Apr 18 20:40:05 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen' - status: 'OOS' ignoring
Apr 18 20:40:05 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon' - type: 'shelly-ht-plus' ignoring
Apr 18 20:40:08 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Apr 18 20:40:10 srv4hai meter.sh: SHELLY 'shelly-15/15-Test Weiss':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Apr 18 20:40:10 srv4hai meter.sh: SHELLY 'shelly-30/30-TBD' - status: 'OOS' ignoring
Apr 18 20:40:10 srv4hai meter.sh: SHELLY 'shelly-31/31-Test i3' - status: 'OOS' ignoring
Apr 18 20:40:10 srv4hai meter.sh: SHELLY 'shelly-32/32-TBD' - status: 'OOS' ignoring
Apr 18 20:40:10 srv4hai meter.sh: SHELLY 'shelly-33/33-TBD' - status: 'OOS' ignoring
Apr 18 20:40:10 srv4hai meter.sh: SHELLY 'shelly-36/36-TBD' - status: 'OOS' ignoring
Apr 18 20:40:13 srv4hai meter.sh: SHELLY 'shelly-47/47-plus1-Test':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Apr 18 20:40:13 srv4hai meter.sh: SHELLY 'shelly-09a/Inbetriebnahme - 20210720 - Defekt' - status: 'defect' ignoring
Apr 18 20:40:13 srv4hai meter.sh: SHELLY 'shelly-09b/Sophie Licht - 20230404 - Defekt' - status: 'defect' ignoring
Apr 18 20:40:13 srv4hai meter.sh: SHELLY 'shelly-26/20230404 - kein WLAN' - status: 'defect' ignoring
Apr 18 20:40:13 srv4hai meter.sh: SHELLY 'shelly-27/Schalter Herdzeile - Defekt WLAN 20230417' - status: 'defect' ignoring
Apr 18 20:40:13 srv4hai meter.sh: SHELLY 'shelly-21/Badezimmer - 20230720 - WLAN Problem' - status: 'defect' ignoring
Apr 18 20:40:13 srv4hai meter.sh: SHELLY 'shelly-11/Ausgangstransistor defekt 20230722' - status: 'defect' ignoring
Apr 18 20:40:13 srv4hai meter.sh: SHELLY 'shelly-43/43-TBD' - status: 'OOS' ignoring
Apr 18 20:40:13 srv4hai meter.sh: SHELLY 'shelly-44/44-TBD' - status: 'OOS' ignoring
Apr 18 20:40:13 srv4hai meter.sh: SHELLY 'shelly-45/45-TBD' - status: 'OOS' ignoring
Apr 18 20:40:13 srv4hai meter.sh: SHELLY 'shelly-46/46-TBD' - status: 'OOS' ignoring
Apr 18 20:40:16 srv4hai meter.sh: SHELLY 'shelly-48/48-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Apr 18 20:40:18 srv4hai meter.sh: SHELLY 'shelly-58/Werkstatt Licht':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Apr 18 20:40:18 srv4hai meter.sh: SHELLY 'shelly-59/Werkstatt Schalter Kellertür' - type: 'shelly-i3' ignoring
Apr 18 20:40:18 srv4hai common[5011]: SHELLY common.sh inkludiert von ./check_presence.sh
Apr 18 20:40:19 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'4'=1713465619-1713465615
Apr 18 20:40:19 srv4hai check_presence[5011]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Apr 18 20:40:19 srv4hai check_presence[5011]: SHELLY (meter.sh)-(99) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Apr 18 20:40:19 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'4'=1713465619-1713465615
Apr 18 20:40:19 srv4hai check_presence[5011]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Apr 18 20:40:19 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'4'=1713465619-1713465615
Apr 18 20:40:19 srv4hai check_presence[5011]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Apr 18 20:40:19 srv4hai check_presence[5011]: SHELLY (meter.sh)-(99) what: 'presence' - persPresent: '(BT/LIVE) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Apr 18 20:40:19 srv4hai check_presence[5011]: SHELLY (meter.sh)-(99)-presence: NOT activate_scenario.shtml: offAll
Apr 18 20:40:19 srv4hai common[5011]: SHELLY common.sh inkludiert von ./check_shelly.sh
Apr 18 20:40:19 srv4hai check_shelly.sh: SHELLY last scenery executed: 'buero_UM'
Apr 18 20:40:19 srv4hai check_shelly.sh: SHELLY found '3' active shelly outputs
Apr 18 20:40:19 srv4hai meter.sh: SHELLY meter.sh ended
Apr 18 20:40:19 srv4hai postfix/pickup[22603]: 8FDC16022F: uid=33 from=
Apr 18 20:40:19 srv4hai postfix/cleanup[6067]: 8FDC16022F: message-id=<20240418184019.8FDC16022F@mail.viehai.at>
Apr 18 20:40:19 srv4hai postfix/qmgr[15291]: 8FDC16022F: from=, size=642, nrcpt=1 (queue active)
Apr 18 20:40:19 srv4hai postfix/local[6069]: 8FDC16022F: to=, orig_to=, relay=local, delay=0.05, delays=0.02/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Apr 18 20:40:19 srv4hai postfix/qmgr[15291]: 8FDC16022F: removed
Apr 18 20:41:01 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=6079, secured, session=<35gPUGMWstcAAAAAAAAAAAAAAAAAAAAB>
Apr 18 20:41:01 srv4hai dovecot: imap(rozumm)<6079><35gPUGMWstcAAAAAAAAAAAAAAAAAAAAB>: Logged out in=93 out=1063 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 18 20:41:01 srv4hai CRON[6081]: (root) CMD (/etc/linetest/linetest.sh)
Apr 18 20:41:01 srv4hai ping_SP[14320]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1713465661 - 'ping_SP_0'
Apr 18 20:41:01 srv4hai ping_SP[14320]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 18 20:41:37 srv4hai dhcpd[28085]: DHCPDISCOVER from 00:22:61:78:ac:78 via enp2s0
Apr 18 20:41:37 srv4hai dhcpd[28085]: DHCPOFFER on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Apr 18 20:41:40 srv4hai dhcpd[28085]: DHCPDISCOVER from 00:22:61:78:ac:78 via enp2s0
Apr 18 20:41:40 srv4hai dhcpd[28085]: DHCPOFFER on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Apr 18 20:41:40 srv4hai dhcpd[28085]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Apr 18 20:41:40 srv4hai dhcpd[28085]: execute_statement argv[1] = 192.168.12.25
Apr 18 20:41:40 srv4hai dhcpd[28085]: execute_statement argv[2] = RadioKueche
Apr 18 20:41:40 srv4hai dhcpd[28085]: DHCPREQUEST for 192.168.12.25 (192.168.12.252) from 00:22:61:78:ac:78 via enp2s0
Apr 18 20:41:40 srv4hai dhcpd[28085]: DHCPACK on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Apr 18 20:41:40 srv4hai named[15509]: client @0x7f930c03c330 192.168.12.252#35433/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: RadioKueche.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 18 20:41:40 srv4hai named[15509]: client @0x7f931c100b10 192.168.12.252#39527/key rndc-key: signer "rndc-key" approved
Apr 18 20:41:40 srv4hai named[15509]: client @0x7f931c100b10 192.168.12.252#39527/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'RadioKueche.viehai.at' TXT
Apr 18 20:41:40 srv4hai named[15509]: client @0x7f931c100b10 192.168.12.252#39527/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'RadioKueche.viehai.at' TXT "00ea454d9e8190f8e991b9433de6ed5bf8"
Apr 18 20:41:40 srv4hai named[15509]: client @0x7f931c100b10 192.168.12.252#39527/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'RadioKueche.viehai.at' A
Apr 18 20:41:40 srv4hai named[15509]: client @0x7f931c100b10 192.168.12.252#39527/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'RadioKueche.viehai.at' A 192.168.12.25
Apr 18 20:41:40 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.25'(25) device 'RadioKueche'
Apr 18 20:41:40 srv4hai dhcpd[28085]: Added new forward map from RadioKueche.viehai.at to 192.168.12.25
Apr 18 20:41:40 srv4hai named[15509]: client @0x7f93140740a0 192.168.12.252#52747/key rndc-key: signer "rndc-key" approved
Apr 18 20:41:40 srv4hai named[15509]: client @0x7f93140740a0 192.168.12.252#52747/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '25.12.168.192.in-addr.arpa' PTR
Apr 18 20:41:40 srv4hai named[15509]: client @0x7f93140740a0 192.168.12.252#52747/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '25.12.168.192.in-addr.arpa' PTR RadioKueche.viehai.at.
Apr 18 20:41:40 srv4hai dhcpd[28085]: Added reverse map from 25.12.168.192.in-addr.arpa. to RadioKueche.viehai.at
Apr 18 20:41:40 srv4hai dhcpcommit.sh: SHELLY device 'RadioKueche' known and accepted
Apr 18 20:41:44 srv4hai dhcpd[28085]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Apr 18 20:41:44 srv4hai dhcpd[28085]: execute_statement argv[1] = 192.168.12.25
Apr 18 20:41:44 srv4hai dhcpd[28085]: execute_statement argv[2] = RadioKueche
Apr 18 20:41:44 srv4hai dhcpd[28085]: DHCPREQUEST for 192.168.12.25 (192.168.12.252) from 00:22:61:78:ac:78 via enp2s0
Apr 18 20:41:44 srv4hai dhcpd[28085]: DHCPACK on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Apr 18 20:41:44 srv4hai named[15509]: client @0x7f931c66c140 192.168.12.252#49889/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: RadioKueche.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 18 20:41:44 srv4hai named[15509]: client @0x7f9314074a80 192.168.12.252#42603/key rndc-key: signer "rndc-key" approved
Apr 18 20:41:44 srv4hai named[15509]: client @0x7f9314074a80 192.168.12.252#42603/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'RadioKueche.viehai.at' TXT
Apr 18 20:41:44 srv4hai named[15509]: client @0x7f9314074a80 192.168.12.252#42603/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'RadioKueche.viehai.at' TXT "00ea454d9e8190f8e991b9433de6ed5bf8"
Apr 18 20:41:44 srv4hai named[15509]: client @0x7f9314074a80 192.168.12.252#42603/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'RadioKueche.viehai.at' A
Apr 18 20:41:44 srv4hai named[15509]: client @0x7f9314074a80 192.168.12.252#42603/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'RadioKueche.viehai.at' A 192.168.12.25
Apr 18 20:41:44 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.25'(25) device 'RadioKueche'
Apr 18 20:41:44 srv4hai dhcpd[28085]: Added new forward map from RadioKueche.viehai.at to 192.168.12.25
Apr 18 20:41:44 srv4hai named[15509]: client @0x7f930800b8b0 192.168.12.252#38849/key rndc-key: signer "rndc-key" approved
Apr 18 20:41:44 srv4hai named[15509]: client @0x7f930800b8b0 192.168.12.252#38849/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '25.12.168.192.in-addr.arpa' PTR
Apr 18 20:41:44 srv4hai named[15509]: client @0x7f930800b8b0 192.168.12.252#38849/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '25.12.168.192.in-addr.arpa' PTR RadioKueche.viehai.at.
Apr 18 20:41:44 srv4hai dhcpd[28085]: Added reverse map from 25.12.168.192.in-addr.arpa. to RadioKueche.viehai.at
Apr 18 20:41:44 srv4hai dhcpcommit.sh: SHELLY device 'RadioKueche' known and accepted
Apr 18 20:42:00 srv4hai postfix/smtpd[6117]: warning: hostname myvpsloverg.ip-ptr.tech does not resolve to address 81.19.141.225: Name or service not known
Apr 18 20:42:00 srv4hai postfix/smtpd[6117]: connect from unknown[81.19.141.225]
Apr 18 20:42:00 srv4hai postfix/smtpd[6117]: warning: unknown[81.19.141.225]: SASL LOGIN authentication failed: Invalid authentication mechanism
Apr 18 20:42:00 srv4hai postfix/smtpd[6117]: disconnect from unknown[81.19.141.225] ehlo=1 auth=0/1 rset=1 quit=1 commands=3/4
Apr 18 20:42:01 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=6121, secured, session=
Apr 18 20:42:01 srv4hai dovecot: imap(rozumm)<6121>: Logged out in=93 out=1063 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 18 20:42:01 srv4hai CRON[6124]: (root) CMD (/etc/linetest/linetest.sh)
Apr 18 20:42:14 srv4hai ping_SP[14320]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1713465734 - 'ping_SP_0'
Apr 18 20:42:14 srv4hai ping_SP[14320]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 18 20:42:34 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Apr 18 20:42:34 srv4hai fetchmail[1651]: 42423 messages (42423 seen) for tmiglinci at mail.akis.at (-761815233 octets).
Apr 18 20:42:35 srv4hai fetchmail[1651]: 10151 messages (10151 seen) for srozum at mail.akis.at (1226104254 octets).
Apr 18 20:42:35 srv4hai fetchmail[1651]: 22960 messages (22960 seen) for mrozum at mail.akis.at (-314525527 octets).
Apr 18 20:42:36 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Apr 18 20:42:37 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=6150, secured, session=
Apr 18 20:42:37 srv4hai dovecot: imap(miglincit)<6150>: Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 18 20:42:39 srv4hai dhcpd[28085]: DHCPRELEASE of 192.168.12.25 from 00:22:61:78:ac:78 via enp2s0 (not found)
Apr 18 20:42:54 srv4hai common[6153]: SHELLY common.sh inkludiert von ./bt_scan.sh
Apr 18 20:43:01 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=6166, secured, session=
Apr 18 20:43:01 srv4hai dovecot: imap(rozumm)<6166>: Logged out in=93 out=1063 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 18 20:43:01 srv4hai CRON[6169]: (root) CMD (/etc/linetest/linetest.sh)
Apr 18 20:43:04 srv4hai bt_scan[6153]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Apr 18 20:43:04 srv4hai bt_scan[6153]: SHELLY - ping_SP.sh started for BTmac: '1' - IPv4: '192.168.12.62'
Apr 18 20:43:04 srv4hai common[6192]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Apr 18 20:43:04 srv4hai ping_SP[6192]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Apr 18 20:43:04 srv4hai common[6212]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Apr 18 20:43:04 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'10'=1713465784-1713465774
Apr 18 20:43:04 srv4hai check_presence[6212]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Apr 18 20:43:04 srv4hai check_presence[6212]: SHELLY (ping_SP__bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Apr 18 20:43:04 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'10'=1713465784-1713465774
Apr 18 20:43:04 srv4hai check_presence[6212]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Apr 18 20:43:05 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1713465784-1713465774
Apr 18 20:43:05 srv4hai check_presence[6212]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Apr 18 20:43:05 srv4hai check_presence[6212]: SHELLY (ping_SP__bt_scan)-(1) what: 'coming' - persPresent: '(BT/LIVE) (BT/__) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Apr 18 20:43:05 srv4hai check_presence[6212]: SHELLY (ping_SP__bt_scan)-(1)-coming: activate_scenario.shtml: vorraumOn
Apr 18 20:43:05 srv4hai activate_scenario[6335]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Apr 18 20:43:05 srv4hai activate_scenario[6335]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'1'

finished