activate_scenario.sh
Tue Nov 26 20:37:59 CET 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'

VZ Licht (/srv/www/viehai/shelly/log_scenarios/2024/11/26/_0.log)

vorher: 20:37:59.525

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

nachher: 20:37:59.650
Dauer: 125 msec phName: 'phoneName:'1''


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

urls : 1
vorher : 20:37:59.499
nachher: 20:37:59.657
Dauer : 158 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/11/26//scene_vorraumOn_20241126_203759.txt'


syslog

Nov 26 20:34:00 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27297, secured, session=
Nov 26 20:34:00 srv4hai dovecot: imap(rozumm)<27297>: Logged out in=93 out=1065 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Nov 26 20:34:01 srv4hai CRON[27299]: (root) CMD (/etc/linetest/linetest.sh)
Nov 26 20:34:23 srv4hai ping_SP[16656]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1732649663 - 'ping_SP_0'
Nov 26 20:34:23 srv4hai ping_SP[16656]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Nov 26 20:34:33 srv4hai mosquitto[4998]: Outgoing messages are being dropped for client pchai7x-1.
Nov 26 20:35:00 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27346, secured, session=
Nov 26 20:35:00 srv4hai dovecot: imap(rozumm)<27346>: Logged out in=93 out=1065 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Nov 26 20:35:01 srv4hai CRON[27348]: (root) CMD (/etc/linetest/linetest.sh)
Nov 26 20:35:23 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27361, secured, session=<8nlH89UnJOoAAAAAAAAAAAAAAAAAAAAB>
Nov 26 20:35:23 srv4hai dovecot: imap(miglincit)<27361><8nlH89UnJOoAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Nov 26 20:35:27 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27369, secured, session=
Nov 26 20:35:27 srv4hai dovecot: imap(miglincit)<27369>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Nov 26 20:35:36 srv4hai ping_SP[16656]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1732649736 - 'ping_SP_0'
Nov 26 20:35:36 srv4hai ping_SP[16656]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Nov 26 20:36:00 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27399, secured, session=
Nov 26 20:36:00 srv4hai dovecot: imap(rozumm)<27399>: Logged out in=93 out=1065 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Nov 26 20:36:01 srv4hai CRON[27401]: (root) CMD (/etc/linetest/linetest.sh)
Nov 26 20:36:49 srv4hai ping_SP[16656]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1732649809 - 'ping_SP_0'
Nov 26 20:36:49 srv4hai ping_SP[16656]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Nov 26 20:36:58 srv4hai postfix/anvil[27276]: statistics: max connection rate 1/60s for (smtp:80.94.95.239) at Nov 26 20:33:34
Nov 26 20:36:58 srv4hai postfix/anvil[27276]: statistics: max connection count 1 for (smtp:80.94.95.239) at Nov 26 20:33:34
Nov 26 20:36:58 srv4hai postfix/anvil[27276]: statistics: max cache size 1 at Nov 26 20:33:34
Nov 26 20:37:00 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27447, secured, session=
Nov 26 20:37:00 srv4hai dovecot: imap(rozumm)<27447>: Logged out in=93 out=1065 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Nov 26 20:37:02 srv4hai CRON[27449]: (root) CMD (/etc/linetest/linetest.sh)
Nov 26 20:37:24 srv4hai postfix/smtpd[27460]: connect from unknown[80.94.95.239]
Nov 26 20:37:27 srv4hai postfix/smtpd[27460]: warning: unknown[80.94.95.239]: SASL LOGIN authentication failed: Invalid authentication mechanism
Nov 26 20:37:27 srv4hai dhcpd[21239]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0
Nov 26 20:37:27 srv4hai dhcpd[21239]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
Nov 26 20:37:28 srv4hai postfix/smtpd[27460]: disconnect from unknown[80.94.95.239] ehlo=1 auth=0/1 rset=1 quit=1 commands=3/4
Nov 26 20:37:29 srv4hai dhcpd[21239]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0
Nov 26 20:37:29 srv4hai dhcpd[21239]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
Nov 26 20:37:33 srv4hai dhcpd[21239]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0
Nov 26 20:37:33 srv4hai dhcpd[21239]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
Nov 26 20:37:33 srv4hai dhcpd[21239]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Nov 26 20:37:33 srv4hai dhcpd[21239]: execute_statement argv[1] = 192.168.12.147
Nov 26 20:37:33 srv4hai dhcpd[21239]: execute_statement argv[2] = shelly-47
Nov 26 20:37:33 srv4hai dhcpd[21239]: DHCPREQUEST for 192.168.12.147 (192.168.12.252) from 44:17:93:a5:8a:e4 via enp2s0
Nov 26 20:37:33 srv4hai dhcpd[21239]: DHCPACK on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
Nov 26 20:37:33 srv4hai named[30406]: client @0x7f93380c3840 192.168.12.252#42103/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-47.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Nov 26 20:37:33 srv4hai named[30406]: client @0x7f934c0733f0 192.168.12.252#41353/key rndc-key: signer "rndc-key" approved
Nov 26 20:37:33 srv4hai named[30406]: client @0x7f934c0733f0 192.168.12.252#41353/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' TXT
Nov 26 20:37:33 srv4hai named[30406]: client @0x7f934c0733f0 192.168.12.252#41353/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' TXT "31f97534415d36e3a13ec57b0310c0867f"
Nov 26 20:37:33 srv4hai named[30406]: client @0x7f934c0733f0 192.168.12.252#41353/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' A
Nov 26 20:37:33 srv4hai named[30406]: client @0x7f934c0733f0 192.168.12.252#41353/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' A 192.168.12.147
Nov 26 20:37:33 srv4hai dhcpd[21239]: Added new forward map from shelly-47.viehai.at to 192.168.12.147
Nov 26 20:37:33 srv4hai named[30406]: client @0x7f932c0d1ae0 192.168.12.252#50331/key rndc-key: signer "rndc-key" approved
Nov 26 20:37:33 srv4hai named[30406]: client @0x7f932c0d1ae0 192.168.12.252#50331/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '147.12.168.192.in-addr.arpa' PTR
Nov 26 20:37:33 srv4hai named[30406]: client @0x7f932c0d1ae0 192.168.12.252#50331/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '147.12.168.192.in-addr.arpa' PTR shelly-47.viehai.at.
Nov 26 20:37:33 srv4hai dhcpd[21239]: Added reverse map from 147.12.168.192.in-addr.arpa. to shelly-47.viehai.at
Nov 26 20:37:33 srv4hai common[27464]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Nov 26 20:37:33 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-47' - shIP/2:'' perform:'conf'
Nov 26 20:37:34 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-47' - shIP/2:'192.168.12.147'
Nov 26 20:37:34 srv4hai mosquitto[4998]: New connection from 192.168.12.147 on port 1883.
Nov 26 20:37:34 srv4hai mosquitto[4998]: Client shellyplus1-441793a58ae4 already connected, closing old connection.
Nov 26 20:37:34 srv4hai mosquitto[4998]: Socket error on client shellyplus1-441793a58ae4, disconnecting.
Nov 26 20:37:34 srv4hai mosquitto[4998]: New client connected from 192.168.12.147 as shellyplus1-441793a58ae4 (c1, k60, u'shmqtt').
Nov 26 20:37:34 srv4hai conf_shelly.sh: SHELLY: usage/name 'GB Schreibtischlampe links' already set for '192.168.12.147'
Nov 26 20:37:34 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(0)' - allready transmitted - skipping
Nov 26 20:37:45 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Nov 26 20:37:46 srv4hai fetchmail[1651]: 57776 messages (57776 seen) for tmiglinci at mail.akis.at (449519685 octets).
Nov 26 20:37:46 srv4hai fetchmail[1651]: 11110 messages (11110 seen) for srozum at mail.akis.at (1338384627 octets).
Nov 26 20:37:47 srv4hai fetchmail[1651]: 27467 messages (27467 seen) for mrozum at mail.akis.at (439364354 octets).
Nov 26 20:37:47 srv4hai fetchmail[1651]: 1157 messages (1157 seen) for admin@bastelstube.wien at pop3.world4you.com (52170273 octets).
Nov 26 20:37:48 srv4hai common[27529]: SHELLY common.sh inkludiert von ./bt_scan.sh
Nov 26 20:37:58 srv4hai bt_scan[27529]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Nov 26 20:37:58 srv4hai bt_scan[27529]: SHELLY - ping_SP.sh started for BTmac: '1' - IPv4: '192.168.12.62'
Nov 26 20:37:58 srv4hai common[27569]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Nov 26 20:37:58 srv4hai ping_SP[27569]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Nov 26 20:37:58 srv4hai common[27590]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Nov 26 20:37:59 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'11'=1732649879-1732649868
Nov 26 20:37:59 srv4hai check_presence[27590]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Nov 26 20:37:59 srv4hai check_presence[27590]: SHELLY (ping_SP__bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Nov 26 20:37:59 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'11'=1732649879-1732649868
Nov 26 20:37:59 srv4hai check_presence[27590]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Nov 26 20:37:59 srv4hai common.sh: SHELLY: BTstatus[2]:'null' dweetAge:'11'=1732649879-1732649868
Nov 26 20:37:59 srv4hai check_presence[27590]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and null//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Nov 26 20:37:59 srv4hai check_presence[27590]: SHELLY (ping_SP__bt_scan)-(1) what: 'coming' - persPresent: '(__/LIVE) (BT/__) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Nov 26 20:37:59 srv4hai check_presence[27590]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_pcON) - sceneONsmall(vorraumOn)
Nov 26 20:37:59 srv4hai check_presence[27590]: SHELLY (ping_SP__bt_scan)-(1)-coming: activate_scenario.shtml: vorraumOn
Nov 26 20:37:59 srv4hai activate_scenario[27736]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Nov 26 20:37:59 srv4hai activate_scenario[27736]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'1'

finished